Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.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.0007499/0.0007499, allocations: 68.19 kB / 9.881 MB, free: 0.8086 MB / 10.45 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001037/0.001787, allocations: 447.8 kB / 10.32 MB, free: 380 kB / 10.45 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.001179/0.001179, allocations: 153.2 kB / 11.21 MB, free: 2.965 MB / 13.93 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001472/0.002651, allocations: 463.6 kB / 11.66 MB, free: 2.508 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.8408/0.8408, allocations: 158.6 MB / 171 MB, free: 2.598 MB / 170.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.1239/0.9647, allocations: 49.5 MB / 220.5 MB, free: 1.453 MB / 218.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 2.0.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 2.0.0-master/package.mo): time 0.4945/0.4945, allocations: 100.1 MB / 321.3 MB, free: 5.133 MB / 314.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.0486/0.5431, allocations: 35.54 MB / 356.9 MB, free: 1.891 MB / 346.7 MB
"
[Timeout remaining time 179]
Using package Dynawo with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 2.0.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.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 -s=euler since the model is compiled with --daeMode, which needs -s=ida
Running command: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl,fileNamePrefix="Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl",fmuType="me_cs",version="2.0+3.0",platforms={"static"})
"" <> buildModelFMU(Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl,fileNamePrefix="Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl",fmuType="me_cs",version="2.0+3.0",platforms={"static"}) [Timeout 660]
"Warning: DAE mode (--daeMode) for Model Exchange needs FMI 3.0 or platforms={\"wasm\"}. Exporting Co-Simulation only.
Notification: Performance of FrontEnd - loaded program: time 1.393e-06/1.393e-06, allocations: 0 / 358.3 MB, free: 492 kB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.84e-05/1.98e-05, allocations: 2.312 kB / 358.3 MB, free: 488 kB / 346.7 MB
Notification: Performance of NFInst.instantiate(Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl): time 0.006392/0.006412, allocations: 4.242 MB / 362.5 MB, free: 12.21 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.007686/0.0141, allocations: 5.206 MB / 367.7 MB, free: 7 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003544/0.01445, allocations: 11.94 kB / 367.7 MB, free: 6.988 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0006588/0.01511, allocations: 290 kB / 368 MB, free: 6.703 MB / 362.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'.
Notification: Performance of NFTyping.typeBindings: time 0.0007968/0.01591, allocations: 305.9 kB / 368.3 MB, free: 6.402 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002249/0.01816, allocations: 1.156 MB / 369.5 MB, free: 5.242 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.001326/0.01948, allocations: 1.107 MB / 370.6 MB, free: 4.129 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002516/0.01973, allocations: 113.8 kB / 370.7 MB, free: 4 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0007802/0.02051, allocations: 0.5565 MB / 371.2 MB, free: 3.441 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005599/0.02107, allocations: 394.7 kB / 371.6 MB, free: 3.055 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001401/0.02121, allocations: 84 kB / 371.7 MB, free: 2.973 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006373/0.02185, allocations: 319.6 kB / 372 MB, free: 2.66 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.000224/0.02208, allocations: 191.3 kB / 372.2 MB, free: 2.473 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.000302/0.02238, allocations: 235.4 kB / 372.4 MB, free: 2.242 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001144/0.02352, allocations: 0.8835 MB / 373.3 MB, free: 1.355 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.812e-05/0.02354, allocations: 4 kB / 373.3 MB, free: 1.352 MB / 362.7 MB
Notification: Performance of FrontEnd: time 1.222e-06/0.02354, allocations: 0 / 373.3 MB, free: 1.352 MB / 362.7 MB
Notification: Performance of Transformations before backend: time 1.895e-05/0.02356, allocations: 0 / 373.3 MB, free: 1.352 MB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 157
 * Number of variables: 157
Notification: Performance of Generate backend data structure: time 0.004436/0.028, allocations: 2.09 MB / 375.4 MB, free: 15.2 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.357e-05/0.02804, allocations: 12.03 kB / 375.4 MB, free: 15.18 MB / 378.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001467/0.02819, allocations: 122.6 kB / 375.5 MB, free: 15.05 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001936/0.03012, allocations: 0.4886 MB / 376 MB, free: 14.57 MB / 378.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0006847/0.03081, allocations: 365.4 kB / 376.4 MB, free: 14.18 MB / 378.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004696/0.03128, allocations: 0.9065 MB / 377.3 MB, free: 13.08 MB / 378.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001429/0.03142, allocations: 83.92 kB / 377.4 MB, free: 13 MB / 378.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001141/0.03256, allocations: 0.7354 MB / 378.1 MB, free: 12.2 MB / 378.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.045e-05/0.03258, allocations: 0 / 378.1 MB, free: 12.2 MB / 378.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.495e-05/0.03267, allocations: 35.98 kB / 378.2 MB, free: 12.17 MB / 378.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.814e-05/0.03268, allocations: 16 kB / 378.2 MB, free: 12.15 MB / 378.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006535/0.03334, allocations: 297.5 kB / 378.5 MB, free: 11.86 MB / 378.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.003393/0.03673, allocations: 2.516 MB / 381 MB, free: 9.254 MB / 378.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001017/0.03775, allocations: 499.3 kB / 381.5 MB, free: 8.715 MB / 378.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003445/0.03809, allocations: 190.2 kB / 381.6 MB, free: 8.516 MB / 378.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001284/0.03822, allocations: 32.58 kB / 381.7 MB, free: 8.484 MB / 378.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0009977/0.03922, allocations: 0.734 MB / 382.4 MB, free: 7.719 MB / 378.7 MB
Notification: Performance of pre-optimization done (n=116): time 3.316e-06/0.03922, allocations: 0 / 382.4 MB, free: 7.719 MB / 378.7 MB
Notification: Performance of matching and sorting (n=116): time 0.003293/0.04251, allocations: 1.13 MB / 383.5 MB, free: 6.574 MB / 378.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001035/0.04262, allocations: 238.5 kB / 383.8 MB, free: 6.293 MB / 378.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007512/0.04337, allocations: 0.6496 MB / 384.4 MB, free: 5.629 MB / 378.7 MB
Notification: Performance of collectPreVariables (initialization): time 8.765e-05/0.04346, allocations: 61.69 kB / 384.5 MB, free: 5.562 MB / 378.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001856/0.04364, allocations: 283.3 kB / 384.8 MB, free: 5.281 MB / 378.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003431/0.04398, allocations: 345.3 kB / 385.1 MB, free: 4.941 MB / 378.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003441/0.04433, allocations: 234.7 kB / 385.3 MB, free: 4.703 MB / 378.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001692/0.0445, allocations: 426.4 kB / 385.7 MB, free: 4.277 MB / 378.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005779/0.04508, allocations: 257 kB / 386 MB, free: 4.02 MB / 378.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007116/0.04579, allocations: 492.4 kB / 386.5 MB, free: 3.461 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001784/0.04757, allocations: 1.062 MB / 387.5 MB, free: 2.316 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.331e-06/0.04758, allocations: 4 kB / 387.5 MB, free: 2.312 MB / 378.7 MB
Notification: Performance of matching and sorting (n=179) (initialization): time 0.00321/0.05079, allocations: 1.286 MB / 388.8 MB, free: 0.9961 MB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 5.351e-05/0.05084, allocations: 45.69 kB / 388.9 MB, free: 0.9453 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.189e-05/0.05085, allocations: 7.938 kB / 388.9 MB, free: 0.9375 MB / 378.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001676/0.05253, allocations: 0.5444 MB / 389.4 MB, free: 396 kB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004946/0.05302, allocations: 159.6 kB / 389.6 MB, free: 236 kB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002729/0.05575, allocations: 3.16 MB / 392.7 MB, free: 12.85 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006954/0.05645, allocations: 151.5 kB / 392.9 MB, free: 12.7 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.387e-05/0.05654, allocations: 39.98 kB / 392.9 MB, free: 12.66 MB / 394.7 MB
Warning: Assuming fixed start value for the following 19 variables:
         Line1bis.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Line1bis.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Line1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Line1.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Generator1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Generator1.State0 fixed = true )  \"Generator connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Generator2.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Generator2.State0 fixed = true )  \"Generator connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Generator1.running:DISCRETE(flow=false start = Generator1.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Generator1.limUQDown:DISCRETE(flow=false start = Generator1.limUQDown0 fixed = true )  \"Whether the minimum reactive power limits are reached or not (from generator voltage regulator)\" type: Boolean
         Generator1.limUQUp:DISCRETE(flow=false start = Generator1.limUQUp0 fixed = true )  \"Whether the maximum reactive power limits are reached or not (from generator voltage regulator)\" type: Boolean
         Generator2.running:DISCRETE(flow=false start = Generator2.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Generator2.limUQDown:DISCRETE(flow=false start = Generator2.limUQDown0 fixed = true )  \"Whether the minimum reactive power limits are reached or not (from generator voltage regulator)\" type: Boolean
         Generator2.limUQUp:DISCRETE(flow=false start = Generator2.limUQUp0 fixed = true )  \"Whether the maximum reactive power limits are reached or not (from generator voltage regulator)\" type: Boolean
         Line1.running:DISCRETE(flow=false start = Line1.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Line1bis.running:DISCRETE(flow=false start = Line1bis.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         SignalNQ.deltaUInt:VARIABLE(start = 0.0 unit = \"kV\" fixed = true protected = true )  \"State of the integrator in kV\" type: Real
         SignalNQ.frozen:DISCRETE(start = SignalNQ.Frozen0 fixed = true protected = true )  \"True if the integration is frozen\" type: Boolean
         DisconnectLine.state1:DISCRETE(flow=false fixed = true )  \"Current state\" type: Boolean
         Generator2.qStatus:DISCRETE(min = Generator2.QStatus.Standard max = Generator2.QStatus.GenerationMax start = Generator2.qStatus0 fixed = true protected = true )  \"Voltage regulation status: Standard, AbsorptionMax, GenerationMax\" type: enumeration(Standard, AbsorptionMax, GenerationMax)
         Generator2.pStatus:DISCRETE(min = Generator2.PStatus.Standard max = Generator2.PStatus.LimitPMax start = Generator2.PStatus.Standard fixed = true protected = true )  \"Active power / frequency regulation status: Standard, LimitPMin, LimitPMax\" type: enumeration(Standard, LimitPMin, LimitPMax)
         Generator1.qStatus:DISCRETE(min = Generator1.QStatus.Standard max = Generator1.QStatus.GenerationMax start = Generator1.qStatus0 fixed = true protected = true )  \"Voltage regulation status: Standard, AbsorptionMax, GenerationMax\" type: enumeration(Standard, AbsorptionMax, GenerationMax)
         Generator1.pStatus:DISCRETE(min = Generator1.PStatus.Standard max = Generator1.PStatus.LimitPMax start = Generator1.PStatus.Standard fixed = true protected = true )  \"Active power / frequency regulation status: Standard, LimitPMin, LimitPMax\" type: enumeration(Standard, LimitPMin, LimitPMax)
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 24
 * Number of states: 0 ()
 * Number of discrete variables: 91 ($PRE.Line1bis.state,Line1bis.state,$PRE.Line1.state,Line1.state,$whenCondition28,$PRE.Generator1.state,Generator1.converter.u,Generator1.state,$PRE.Generator2.state,Generator2.converter.u,Generator2.state,Generator1_INIT.qStatus0,Generator1_INIT.limUQUp0,Generator1_INIT.limUQDown0,Generator2_INIT.qStatus0,Generator2_INIT.limUQUp0,Generator2_INIT.limUQDown0,$PRE.Generator1.running,$PRE.Generator1.limUQDown,$PRE.Generator1.limUQUp,$PRE.Generator2.running,$PRE.Generator2.limUQDown,$PRE.Generator2.limUQUp,$PRE.Line1.running,$PRE.Line1bis.running,$PRE.SignalNQ.frozen,$PRE.DisconnectLine.state1,$PRE.Generator2.qStatus,$PRE.Generator2.pStatus,$PRE.Generator1.qStatus,$PRE.Generator1.pStatus,DisconnectLine.state1,SignalNQ.frozen,SignalNQ.blockedUp,SignalNQ.blockedDown,Line1bis.running,Line1.running,Generator2.qStatus,Generator2.pStatus,Generator2.limUQUp,Generator2.limUQDown,Generator2.running,Generator1.qStatus,Generator1.pStatus,Generator1.limUQUp,Generator1.limUQDown,Generator1.running,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition9,$whenCondition8,$whenCondition10,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition19,$whenCondition18,$whenCondition20,$whenCondition22,$whenCondition21,$whenCondition23,$whenCondition25,$whenCondition24,$whenCondition27,$whenCondition26,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition34,$whenCondition33,$whenCondition32,$whenCondition36,$whenCondition35,Generator1.switchOffSignal1,Generator1.switchOffSignal2,Generator1.switchOffSignal3,Generator2.switchOffSignal1,Generator2.switchOffSignal2,Generator2.switchOffSignal3,Line1.switchOffSignal1,Line1.switchOffSignal2,Line1bis.switchOffSignal1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (147):
 * Single equations (assignments): 143
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(13,11)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004458/0.05699, allocations: 331.5 kB / 393.3 MB, free: 12.34 MB / 394.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001966/0.05718, allocations: 123.9 kB / 393.4 MB, free: 12.22 MB / 394.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001123/0.05831, allocations: 0.6588 MB / 394 MB, free: 11.55 MB / 394.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.426e-05/0.05832, allocations: 11.95 kB / 394 MB, free: 11.54 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.118e-06/0.05833, allocations: 0 / 394 MB, free: 11.54 MB / 394.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001465/0.05847, allocations: 91.27 kB / 394.1 MB, free: 11.45 MB / 394.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.228e-05/0.05854, allocations: 27.97 kB / 394.2 MB, free: 11.42 MB / 394.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001242/0.05867, allocations: 31.97 kB / 394.2 MB, free: 11.39 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004871/0.05916, allocations: 71.92 kB / 394.3 MB, free: 11.32 MB / 394.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002684/0.05942, allocations: 132.7 kB / 394.4 MB, free: 11.19 MB / 394.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001723/0.06115, allocations: 1.216 MB / 395.6 MB, free: 9.945 MB / 394.7 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001583/0.06273, allocations: 1.425 MB / 397 MB, free: 8.508 MB / 394.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0003965/0.06313, allocations: 234.6 kB / 397.3 MB, free: 8.273 MB / 394.7 MB
Notification: Performance of sorting global known variables: time 0.0005767/0.0637, allocations: 288.5 kB / 397.5 MB, free: 7.988 MB / 394.7 MB
Notification: Performance of Backend: time 4.21e-07/0.0637, allocations: 0 / 397.5 MB, free: 7.988 MB / 394.7 MB
Notification: Performance of simCode: created initialization part: time 0.004694/0.0684, allocations: 1.73 MB / 399.3 MB, free: 6.445 MB / 394.7 MB
Notification: Performance of SimCode: time 0.003519/0.07192, allocations: 2.622 MB / 401.9 MB, free: 3.758 MB / 394.7 MB
Notification: Performance of FMU documentation: time 0.07339/0.1453, allocations: 33.65 MB / 435.5 MB, free: 2.176 MB / 426.7 MB
Notification: Performance of Templates: time 0.06023/0.2055, allocations: 1.414 MB / 437 MB, free: 0.6836 MB / 426.7 MB
Notification: FMU-only work: backend 0, simCode 6.051e-05, templates 0
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.00337/0.2089, allocations: 5.938 kB / 437 MB, free: 0.6797 MB / 426.7 MB
Notification: Building FMU for platform 'static' (1/1).
Notification: Finished FMU for platform 'static' (1/1).
Notification: Performance of buildModelFMU: Generate platform static: time 3.044/3.253, allocations: 19.25 kB / 437 MB, free: 0.6641 MB / 426.7 MB
"
[Timeout remaining time 657]
(rm -f Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.pipe >> ../files/Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_res.mat --stripRoot --tempDir=temp_Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_fmu --startTime=0 --stopTime=3000 --stepSize=10 --mode=me --timeout=240 --tolerance=1e-06 ../Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl.fmu) > Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl.pipe 2>&1) [Timeout 252.0]
OMSimulator failed or timed out simulating it; the others still get to run it
(rm -f Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode.sim & (cd run_OMSimulator-cs-cvode && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode_res.mat --stripRoot --tempDir=temp_Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_OMSimulator-cs-cvode_fmu --startTime=0 --stopTime=3000 --stepSize=10 --mode=cs --timeout=240 --tolerance=1e-06 ../Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_OMSimulator-cs-cvode.fmu) > Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode.pipe 2>&1) [Timeout 252.0]
diffSimulationResults("Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-cvode_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_res.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
(rm -f Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler.sim & (cd run_OMSimulator-cs-euler && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler_res.mat --stripRoot --tempDir=temp_Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_OMSimulator-cs-euler_fmu --startTime=0 --stopTime=3000 --stepSize=10 --mode=cs --timeout=240 --tolerance=1e-06 ../Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_OMSimulator-cs-euler.fmu) > Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler.pipe 2>&1) [Timeout 252.0]
diffSimulationResults("Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_OMSimulator-cs-euler_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_res.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
(rm -f Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy_res.csv --output-variables Generator1.PGenPu Generator1.QGenPu Generator1.UPu Generator2.PGenPu Generator2.QGenPu Generator2.UPu --start-time 0 --stop-time 3000 --timeout 240 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 10 ../Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl.fmu) > Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy.pipe 2>&1) [Timeout 252.0]
fmpy timed out simulating the FMU
(rm -f Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode.sim & (cd run_fmpy-fmi3-cs-cvode && python3 -m fmpy simulate --output-file ../Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode_res.csv --output-variables Generator1.PGenPu Generator1.QGenPu Generator1.UPu Generator2.PGenPu Generator2.QGenPu Generator2.UPu --start-time 0 --stop-time 3000 --timeout 240 --relative-tolerance 1e-06 --interface-type CoSimulation --output-interval 10 ../Dynawo_dev_Dynawo_Examples_IllustrativeExamples_DynaFlow_CoordinatedVControl_fmpy-fmi3-cs-cvode.fmu) > Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode.pipe 2>&1) [Timeout 252.0]
diffSimulationResults("Dynawo_dev_Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_fmpy-fmi3-cs-cvode_res.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.IllustrativeExamples.DynaFlow.CoordinatedVControl_res.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 6.263200690969825]