Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.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.001141/0.001141, allocations: 114.4 kB / 19.71 MB, free: 0.5 MB / 13.93 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.001197/0.001197, allocations: 217.9 kB / 23.03 MB, free: 3.082 MB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.9185/0.9185, allocations: 207.6 MB / 233.8 MB, free: 4.75 MB / 186.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.4348/0.4348, allocations: 121.4 MB / 407.5 MB, free: 3.531 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 -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: "" <> buildModelFMU(Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC,fileNamePrefix="Dynawo_dev_Dynawo_Examples_BESS_WECC_BESSCurrentSourceNoPPC",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC,fileNamePrefix="Dynawo_dev_Dynawo_Examples_BESS_WECC_BESSCurrentSourceNoPPC",fmuType="me",version="2.0",platforms={"static"}) [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.001096/0.001096, allocations: 76.58 kB / 0.5777 GB, free: 28.29 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1016/0.1027, allocations: 80.46 MB / 0.6562 GB, free: 12.59 MB / 0.4948 GB
Notification: Performance of NFInst.instantiate(Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC): time 0.008342/0.111, allocations: 10.83 MB / 0.6668 GB, free: 1.699 MB / 0.4948 GB
Notification: Performance of NFInst.instExpressions: time 0.005522/0.1165, allocations: 5.288 MB / 0.672 GB, free: 12.39 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008515/0.1174, allocations: 59.56 kB / 0.672 GB, free: 12.34 MB / 0.5105 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 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 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 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 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 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 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 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 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 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 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.001005/0.1184, allocations: 0.6635 MB / 0.6727 GB, free: 11.67 MB / 0.5105 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'.
Notification: Performance of NFTyping.typeBindings: time 0.001498/0.1199, allocations: 0.9865 MB / 0.6736 GB, free: 10.68 MB / 0.5105 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Examples/BESS/WECC/BESSCurrentSourceNoPPC.mo:171:3-171:38:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Examples/BESS/WECC/BESSCurrentSourceNoPPC.mo:173:3-173:47:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Examples/BESS/WECC/BESSCurrentSourceNoPPC.mo:174:3-174:47:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 master/Electrical/Controls/WECC/BaseClasses_INIT/WECCInverterCurrentSource_INIT.mo:94:3-94:90:writable] Warning: In relation Modelica.ComplexMath.'abs'(wt4CurrentSource_INIT.s0Pu) == 0.0, == on Real numbers is only allowed inside functions.
Notification: Performance of NFTyping.typeClassSections: time 0.002283/0.1222, allocations: 2.081 MB / 0.6757 GB, free: 8.605 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.002404/0.1246, allocations: 3.27 MB / 0.6789 GB, free: 5.332 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008346/0.1254, allocations: 0.735 MB / 0.6796 GB, free: 4.547 MB / 0.5105 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001007/0.1264, allocations: 1.233 MB / 0.6808 GB, free: 3.309 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009299/0.1274, allocations: 1.341 MB / 0.6821 GB, free: 1.961 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002878/0.1276, allocations: 340 kB / 0.6824 GB, free: 1.629 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006349/0.1283, allocations: 0.613 MB / 0.683 GB, free: 1.016 MB / 0.5105 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003917/0.1287, allocations: 0.728 MB / 0.6837 GB, free: 292 kB / 0.5105 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007391/0.1294, allocations: 1.403 MB / 0.6851 GB, free: 14.87 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.002767/0.1322, allocations: 4.308 MB / 0.6893 GB, free: 10.55 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 3.908e-06/0.1322, allocations: 0 / 0.6893 GB, free: 10.55 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 1.522e-06/0.1322, allocations: 0 / 0.6893 GB, free: 10.55 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 3.014e-05/0.1322, allocations: 0 / 0.6893 GB, free: 10.55 MB / 0.5261 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 434
 * Number of variables: 434
Notification: Performance of Generate backend data structure: time 0.004686/0.1369, allocations: 3.657 MB / 0.6929 GB, free: 6.828 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 3.573e-05/0.1369, allocations: 8.031 kB / 0.6929 GB, free: 6.82 MB / 0.5261 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002151/0.1372, allocations: 253.1 kB / 0.6931 GB, free: 6.562 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001641/0.1388, allocations: 0.6782 MB / 0.6938 GB, free: 5.883 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001797/0.1406, allocations: 1.709 MB / 0.6955 GB, free: 4.121 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003302/0.1409, allocations: 0.7564 MB / 0.6962 GB, free: 3.223 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001767/0.1411, allocations: 180 kB / 0.6964 GB, free: 3.047 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002537/0.1436, allocations: 2.204 MB / 0.6985 GB, free: 0.7422 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.273e-05/0.1437, allocations: 0 / 0.6985 GB, free: 0.7422 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001183/0.1438, allocations: 80 kB / 0.6986 GB, free: 0.6641 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.176e-05/0.1438, allocations: 40 kB / 0.6986 GB, free: 0.625 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002524/0.1463, allocations: 1.889 MB / 0.7005 GB, free: 14.73 MB / 0.5417 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.007249/0.1536, allocations: 8.891 MB / 0.7092 GB, free: 5.398 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00259/0.1562, allocations: 1.78 MB / 0.7109 GB, free: 3.598 MB / 0.5417 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001039/0.1572, allocations: 0.7972 MB / 0.7117 GB, free: 2.797 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001134/0.1573, allocations: 32.97 kB / 0.7117 GB, free: 2.766 MB / 0.5417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001388/0.1587, allocations: 1.127 MB / 0.7128 GB, free: 1.621 MB / 0.5417 GB
Notification: Performance of pre-optimization done (n=146): time 2.234e-06/0.1587, allocations: 3.938 kB / 0.7128 GB, free: 1.617 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=146): time 0.004526/0.1632, allocations: 3.003 MB / 0.7157 GB, free: 14.61 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.346e-05/0.1633, allocations: 286.2 kB / 0.716 GB, free: 14.27 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002022/0.1653, allocations: 2.303 MB / 0.7183 GB, free: 11.94 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 8.765e-05/0.1654, allocations: 61.7 kB / 0.7183 GB, free: 11.87 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006492/0.1661, allocations: 1.045 MB / 0.7193 GB, free: 10.81 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003659/0.1664, allocations: 0.5192 MB / 0.7199 GB, free: 10.29 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005079/0.167, allocations: 476.8 kB / 0.7203 GB, free: 9.816 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 6.755e-05/0.167, allocations: 305.1 kB / 0.7206 GB, free: 9.516 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001374/0.1684, allocations: 1.022 MB / 0.7216 GB, free: 8.484 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001663/0.1701, allocations: 1.416 MB / 0.723 GB, free: 6.938 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008876/0.1789, allocations: 5.369 MB / 0.7282 GB, free: 1.395 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.943e-06/0.1789, allocations: 4 kB / 0.7282 GB, free: 1.391 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=321) (initialization): time 0.00425/0.1832, allocations: 3.147 MB / 0.7313 GB, free: 14.19 MB / 0.573 GB
Notification: Performance of prepare postOptimizeDAE: time 4.673e-05/0.1832, allocations: 61.61 kB / 0.7314 GB, free: 14.12 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.216e-05/0.1833, allocations: 8 kB / 0.7314 GB, free: 14.11 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003711/0.1836, allocations: 268.8 kB / 0.7316 GB, free: 13.85 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001246/0.1849, allocations: 0.5266 MB / 0.7321 GB, free: 13.32 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002236/0.1871, allocations: 2.546 MB / 0.7346 GB, free: 10.66 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001003/0.1881, allocations: 302.4 kB / 0.7349 GB, free: 10.36 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001251/0.1882, allocations: 87.98 kB / 0.735 GB, free: 10.28 MB / 0.573 GB
Warning: Assuming fixed start value for the following 18 variables:
         BESS.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESS.LvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESS.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESS.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         line.running.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
         BESS.reecC.firstOrder.y:VARIABLE(flow=false start = BESS.reecC.UConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.firstOrder1.y:VARIABLE(flow=false start = BESS.reecC.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.limPIDFreeze.I.y:VARIABLE(flow=false start = BESS.reecC.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESS.reecC.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESS.reecC.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.varLimPIDFreeze.I.y:VARIABLE(flow=false start = BESS.reecC.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = BESS.regcA.rateLimFirstOrderFreeze2.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESS.regcA.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.firstOrder.y:VARIABLE(flow=false start = BESS.regcA.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true )  type: Boolean
         BESS.regcA.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true )  type: Real
         BESS.injector.running.value:DISCRETE(flow=false start = BESS.injector.Running0 fixed = true )  type: Boolean
         BESS.LvTfo.running.value:DISCRETE(flow=false start = BESS.LvTfo.Running0 fixed = true )  type: Boolean
         BESS.regcA.offDelay.u:DISCRETE(flow=false fixed = true )  \"Boolean input signal\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00209/0.1903, allocations: 1.511 MB / 0.7365 GB, free: 8.766 MB / 0.573 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00157/0.1919, allocations: 1.407 MB / 0.7378 GB, free: 7.23 MB / 0.573 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.008495/0.2004, allocations: 5.323 MB / 0.743 GB, free: 1.723 MB / 0.573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.332e-06/0.2004, allocations: 3.984 kB / 0.743 GB, free: 1.719 MB / 0.573 GB
Notification: Performance of matching and sorting (n=321) (initialization_lambda0): time 0.2486/0.449, allocations: 3.114 MB / 0.7461 GB, free: 85.25 MB / 0.573 GB
Notification: Performance of prepare postOptimizeDAE: time 4.352e-05/0.449, allocations: 54.78 kB / 0.7461 GB, free: 85.22 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.899e-06/0.4491, allocations: 7.562 kB / 0.7461 GB, free: 85.22 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003487/0.4494, allocations: 277.8 kB / 0.7464 GB, free: 85.21 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001351/0.4508, allocations: 0.531 MB / 0.7469 GB, free: 85.21 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002073/0.4528, allocations: 2.526 MB / 0.7494 GB, free: 83.89 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001233/0.4541, allocations: 271.4 kB / 0.7497 GB, free: 83.85 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001208/0.4542, allocations: 84.91 kB / 0.7497 GB, free: 83.84 MB / 0.573 GB
Warning: Assuming fixed start value for the following 18 variables:
         BESS.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESS.LvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESS.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESS.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         line.running.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
         BESS.reecC.firstOrder.y:VARIABLE(flow=false start = BESS.reecC.UConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.firstOrder1.y:VARIABLE(flow=false start = BESS.reecC.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.limPIDFreeze.I.y:VARIABLE(flow=false start = BESS.reecC.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESS.reecC.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESS.reecC.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.reecC.varLimPIDFreeze.I.y:VARIABLE(flow=false start = BESS.reecC.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = BESS.regcA.rateLimFirstOrderFreeze2.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESS.regcA.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.firstOrder.y:VARIABLE(flow=false start = BESS.regcA.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESS.regcA.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true )  type: Boolean
         BESS.regcA.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true )  type: Real
         BESS.injector.running.value:DISCRETE(flow=false start = BESS.injector.Running0 fixed = true )  type: Boolean
         BESS.LvTfo.running.value:DISCRETE(flow=false start = BESS.LvTfo.Running0 fixed = true )  type: Boolean
         BESS.regcA.offDelay.u:DISCRETE(flow=false fixed = true )  \"Boolean input signal\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 33
 * Number of states: 0 ()
 * Number of discrete variables: 50 ($PRE.BESS.LvTfo.state,BESS.LvTfo.state,$PRE.BESS.injector.state,BESS.injector.state,$PRE.line.state,line.state,BESS.injector.switchOffSignal3.value,BESS.injector.switchOffSignal2.value,BESS.injector.switchOffSignal1.value,line.switchOffSignal2.value,line.switchOffSignal1.value,BESS.regcA.rateLimFirstOrderFreeze1.local_freeze,BESS.regcA.rateLimFirstOrderFreeze2.local_freeze,$PRE.line.running.value,$PRE.BESS.regcA.offDelay.delaySignal,$PRE.BESS.regcA.offDelay.tNext,$PRE.BESS.injector.running.value,$PRE.BESS.LvTfo.running.value,BESS.regcA.QConv0PuPos.k,BESS.regcA.and1.u[1],BESS.regcA.QConv0PuPos.y,BESS.regcA.QConv0PuNeg.k,BESS.regcA.and2.u[2],BESS.regcA.QConv0PuNeg.y,$PRE.BESS.regcA.offDelay.u,BESS.LvTfo.running.value,BESS.injector.running.value,BESS.regcA.and2.y,BESS.regcA.and1.y,BESS.regcA.and1.u[2],BESS.regcA.offDelay.tNext,BESS.regcA.offDelay.delaySignal,BESS.regcA.offDelay.u,line.running.value,$whenCondition2,$whenCondition1,$whenCondition3,$whenCondition5,$whenCondition4,$whenCondition7,$whenCondition6,$whenCondition8,$whenCondition10,$whenCondition9,$whenCondition11,BESS.pll.limIntegrator.local_reset,BESS.pll.integrator.local_reset,BESS.reecC.integrator.local_reset,BESS.reecC.varLimPIDFreeze.I.resetLocal,BESS.reecC.limPIDFreeze.I.resetLocal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (295):
 * Single equations (assignments): 293
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(8,2,50.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0004893/0.4547, allocations: 405.6 kB / 0.7501 GB, free: 83.56 MB / 0.573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002355/0.4549, allocations: 249.4 kB / 0.7504 GB, free: 83.56 MB / 0.573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003724/0.4586, allocations: 2.29 MB / 0.7526 GB, free: 82.7 MB / 0.573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.986e-05/0.4586, allocations: 14.81 kB / 0.7526 GB, free: 82.7 MB / 0.573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.165e-06/0.4587, allocations: 2.5 kB / 0.7526 GB, free: 82.7 MB / 0.573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.467e-05/0.4587, allocations: 8.703 kB / 0.7526 GB, free: 82.7 MB / 0.573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006513/0.4652, allocations: 5.075 MB / 0.7576 GB, free: 80.44 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.232e-06/0.4652, allocations: 7.078 kB / 0.7576 GB, free: 80.44 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001073/0.4663, allocations: 338.2 kB / 0.7579 GB, free: 80.42 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003407/0.4666, allocations: 271.4 kB / 0.7582 GB, free: 80.34 MB / 0.573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.892e-05/0.4667, allocations: 45.95 kB / 0.7582 GB, free: 80.32 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00188/0.4686, allocations: 2.516 MB / 0.7607 GB, free: 78.41 MB / 0.573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.178e-06/0.4686, allocations: 4.516 kB / 0.7607 GB, free: 78.41 MB / 0.573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004349/0.4729, allocations: 3.617 MB / 0.7642 GB, free: 76.88 MB / 0.573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005708/0.4735, allocations: 485.6 kB / 0.7647 GB, free: 76.59 MB / 0.573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001594/0.4736, allocations: 42.52 kB / 0.7647 GB, free: 76.57 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006674/0.4743, allocations: 142.7 kB / 0.7648 GB, free: 76.54 MB / 0.573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002218/0.4745, allocations: 142 kB / 0.765 GB, free: 76.51 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.74e-05/0.4746, allocations: 53.77 kB / 0.765 GB, free: 76.5 MB / 0.573 GB
Notification: Performance of sorting global known variables: time 0.001521/0.4761, allocations: 1.522 MB / 0.7665 GB, free: 75.91 MB / 0.573 GB
Notification: Performance of sort global known variables: time 2.51e-07/0.4761, allocations: 0 / 0.7665 GB, free: 75.91 MB / 0.573 GB
Notification: Performance of remove unused functions: time 0.001887/0.478, allocations: 1.009 MB / 0.7675 GB, free: 75.73 MB / 0.573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 15
 * Number of states: 13 (BESS.reecC.firstOrder.y,BESS.reecC.firstOrder1.y,BESS.reecC.limPIDFreeze.I.y,BESS.reecC.rateLimFirstOrderFreeze1.y,BESS.reecC.slewRateLimiter.y,BESS.reecC.rateLimFirstOrderFreeze.y,BESS.reecC.varLimPIDFreeze.I.y,BESS.reecC.integrator.y,BESS.regcA.rateLimFirstOrderFreeze2.y,BESS.regcA.rateLimFirstOrderFreeze1.y,BESS.regcA.firstOrder.y,BESS.pll.integrator.y,BESS.pll.limIntegrator.y)
 * Number of discrete variables: 23 ($whenCondition11,$whenCondition9,$whenCondition10,$whenCondition8,$whenCondition6,$whenCondition7,$whenCondition4,$whenCondition5,$whenCondition3,$whenCondition1,$whenCondition2,line.running.value,line.state,BESS.regcA.offDelay.u,BESS.regcA.offDelay.delaySignal,BESS.regcA.offDelay.tNext,BESS.regcA.and1.u[2],BESS.regcA.and1.y,BESS.regcA.and2.y,BESS.injector.running.value,BESS.injector.state,BESS.LvTfo.running.value,BESS.LvTfo.state)
 * Number of discrete states: 4 (BESS.LvTfo.running.value,BESS.injector.running.value,line.running.value,BESS.regcA.offDelay.u)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (145):
 * Single equations (assignments): 136
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 8
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(8,2,50.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.005223/0.4832, allocations: 4.525 MB / 0.7719 GB, free: 73.42 MB / 0.573 GB
Notification: Performance of simCode: created initialization part: time 0.005337/0.4886, allocations: 4.121 MB / 0.7759 GB, free: 71.54 MB / 0.573 GB
Notification: Performance of simCode: created event and clocks part: time 3.356e-06/0.4886, allocations: 1.375 kB / 0.7759 GB, free: 71.54 MB / 0.573 GB
Notification: Performance of simCode: created simulation system equations: time 0.001612/0.4902, allocations: 1.284 MB / 0.7772 GB, free: 70.85 MB / 0.573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001105/0.4913, allocations: 347.7 kB / 0.7775 GB, free: 70.65 MB / 0.573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02145/0.5127, allocations: 21.44 MB / 0.7985 GB, free: 54.33 MB / 0.573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006088/0.5134, allocations: 1.549 MB / 0.8 GB, free: 52.75 MB / 0.573 GB
Notification: Performance of simCode: alias equations: time 0.0009351/0.5143, allocations: 315.7 kB / 0.8003 GB, free: 52.44 MB / 0.573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007872/0.5151, allocations: 0.9796 MB / 0.8012 GB, free: 51.46 MB / 0.573 GB
Notification: Performance of SimCode: time 1.092e-06/0.5151, allocations: 0 / 0.8012 GB, free: 51.46 MB / 0.573 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06498/0.5801, allocations: 54.78 MB / 0.8547 GB, free: 12.85 MB / 0.5886 GB
Notification: Performance of buildModelFMU: Generate platform static: time 9.971/10.55, allocations: 11.3 kB / 0.8548 GB, free: 12.84 MB / 0.5886 GB
"
[Timeout remaining time 649]
(rm -f Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.pipe >> ../files/Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.sim & python3 -m fmpy simulate  --output-file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv --start-time 0 --stop-time 20 --timeout 50 --relative-tolerance 1e-05 --interface-type ModelExchange --solver CVode --output-interval 0.001 Dynawo_dev_Dynawo_Examples_BESS_WECC_BESSCurrentSourceNoPPC.fmu > Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.pipe 2>&1) [Timeout 52.5]
diffSimulationResults("Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
"Error: Could not read variable BESS.injector.PInjPuSn in file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv.
Warning: Get data of variable BESS.injector.PInjPuSn from file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv failed!
Error: Could not read variable BESS.injector.QInjPuSn in file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv.
Warning: Get data of variable BESS.injector.QInjPuSn from file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv failed!
Error: Could not read variable BESS.injector.UPu in file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv.
Warning: Get data of variable BESS.injector.UPu from file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv failed!
Error: Could not read variable BESS.reecC.idCmdPu in file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv.
Warning: Get data of variable BESS.reecC.idCmdPu from file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv failed!
Error: Could not read variable BESS.reecC.iqCmdPu in file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv.
Warning: Get data of variable BESS.reecC.iqCmdPu from file Dynawo_dev_Dynawo.Examples.BESS.WECC.BESSCurrentSourceNoPPC_res.csv failed!
"
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 13.529563666786999]