Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.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.002575/0.002575, allocations: 84.45 kB / 19.95 MB, free: 4.602 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.003005/0.003005, allocations: 169.2 kB / 23.23 MB, free: 1.32 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.348/1.348, allocations: 158.6 MB / 185 MB, free: 3.051 MB / 170.7 MB " [Timeout remaining time 178] 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.7466/0.7466, allocations: 100.1 MB / 337.4 MB, free: 5.5 MB / 314.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) Running command: translateModel(Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown,tolerance=1e-06,outputFormat="mat",numberOfIntervals=25000,variableFilter="time|measurements.IpPuSNom",fileNamePrefix="Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown") translateModel(Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown,tolerance=1e-06,outputFormat="mat",numberOfIntervals=25000,variableFilter="time|measurements.IpPuSNom",fileNamePrefix="Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.132e-06/1.132e-06, allocations: 0 / 0.5125 GB, free: 10.28 MB / 442.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 2.107e-05/2.22e-05, allocations: 2.281 kB / 0.5125 GB, free: 10.28 MB / 442.7 MB Notification: Performance of NFInst.instantiate(Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown): time 0.008172/0.008194, allocations: 9.074 MB / 0.5214 GB, free: 3.383 MB / 442.7 MB Notification: Performance of NFInst.instExpressions: time 0.006733/0.01493, allocations: 4.489 MB / 0.5258 GB, free: 15.73 MB / 458.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001408/0.01634, allocations: 45.31 kB / 0.5258 GB, free: 15.72 MB / 458.7 MB Notification: Performance of NFTyping.typeComponents: time 0.001186/0.01752, allocations: 460.4 kB / 0.5262 GB, free: 15.34 MB / 458.7 MB Notification: Performance of NFTyping.typeBindings: time 0.004016/0.02154, allocations: 1.514 MB / 0.5277 GB, free: 14.12 MB / 458.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.002763/0.0243, allocations: 1.285 MB / 0.529 GB, free: 13.04 MB / 458.7 MB Notification: Performance of NFFlatten.flatten: time 0.005376/0.02968, allocations: 3.71 MB / 0.5326 GB, free: 10.59 MB / 458.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001697/0.03137, allocations: 0.7691 MB / 0.5333 GB, free: 9.914 MB / 458.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002052/0.03343, allocations: 1.223 MB / 0.5345 GB, free: 8.688 MB / 458.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.001665/0.03509, allocations: 1.133 MB / 0.5357 GB, free: 7.551 MB / 458.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0006086/0.0357, allocations: 404 kB / 0.536 GB, free: 7.156 MB / 458.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001104/0.0368, allocations: 0.613 MB / 0.5366 GB, free: 6.543 MB / 458.7 MB Notification: Performance of NFScalarize.scalarize: time 0.0007175/0.03752, allocations: 0.7592 MB / 0.5374 GB, free: 5.781 MB / 458.7 MB Notification: Performance of NFVerifyModel.verify: time 0.001387/0.03891, allocations: 0.9932 MB / 0.5383 GB, free: 4.785 MB / 458.7 MB Notification: Performance of NFConvertDAE.convert: time 0.006305/0.04521, allocations: 5.246 MB / 0.5435 GB, free: 15.52 MB / 474.7 MB Notification: Performance of FrontEnd - DAE generated: time 4.949e-06/0.04522, allocations: 0 / 0.5435 GB, free: 15.52 MB / 474.7 MB Notification: Performance of FrontEnd: time 1.403e-06/0.04522, allocations: 0 / 0.5435 GB, free: 15.52 MB / 474.7 MB Notification: Performance of Transformations before backend: time 5.893e-05/0.04528, allocations: 0 / 0.5435 GB, free: 15.52 MB / 474.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 440 * Number of variables: 440 Notification: Performance of Generate backend data structure: time 0.009817/0.05509, allocations: 3.485 MB / 0.5469 GB, free: 11.98 MB / 474.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.055e-05/0.05514, allocations: 15.89 kB / 0.5469 GB, free: 11.96 MB / 474.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005754/0.06089, allocations: 0.975 MB / 0.5478 GB, free: 10.98 MB / 474.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003128/0.06402, allocations: 1.683 MB / 0.5495 GB, free: 9.27 MB / 474.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005858/0.0646, allocations: 0.6059 MB / 0.5501 GB, free: 8.559 MB / 474.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000337/0.06494, allocations: 191.9 kB / 0.5503 GB, free: 8.371 MB / 474.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.004413/0.06935, allocations: 2.076 MB / 0.5523 GB, free: 6.238 MB / 474.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 3.731e-05/0.06939, allocations: 4 kB / 0.5523 GB, free: 6.234 MB / 474.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002034/0.06959, allocations: 75.98 kB / 0.5524 GB, free: 6.16 MB / 474.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.279e-05/0.06964, allocations: 47.94 kB / 0.5524 GB, free: 6.113 MB / 474.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003682/0.07332, allocations: 1.684 MB / 0.5541 GB, free: 4.426 MB / 474.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.05422/0.1275, allocations: 8.673 MB / 0.5625 GB, free: 11.64 MB / 490.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.003816/0.1314, allocations: 1.651 MB / 0.5641 GB, free: 9.973 MB / 490.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001676/0.133, allocations: 0.8192 MB / 0.5649 GB, free: 9.141 MB / 490.7 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0001627/0.1332, allocations: 25.3 kB / 0.565 GB, free: 9.117 MB / 490.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002594/0.1358, allocations: 1.225 MB / 0.5662 GB, free: 7.871 MB / 490.7 MB Notification: Performance of pre-optimization done (n=176): time 3.908e-06/0.1358, allocations: 0 / 0.5662 GB, free: 7.871 MB / 490.7 MB Notification: Performance of matching and sorting (n=176): time 0.00837/0.1442, allocations: 3.041 MB / 0.5691 GB, free: 4.816 MB / 490.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001217/0.1443, allocations: 140 kB / 0.5693 GB, free: 4.656 MB / 490.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003205/0.1475, allocations: 1.78 MB / 0.571 GB, free: 2.871 MB / 490.7 MB Notification: Performance of collectPreVariables (initialization): time 0.0001802/0.1477, allocations: 69.64 kB / 0.5711 GB, free: 2.797 MB / 490.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.001005/0.1487, allocations: 0.9069 MB / 0.5719 GB, free: 1.879 MB / 490.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.0007508/0.1494, allocations: 0.6005 MB / 0.5725 GB, free: 1.273 MB / 490.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006961/0.1501, allocations: 351.8 kB / 0.5729 GB, free: 0.9258 MB / 490.7 MB Notification: Performance of setup shared object (initialization): time 0.0004334/0.1506, allocations: 301.1 kB / 0.5732 GB, free: 0.6289 MB / 490.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001843/0.1524, allocations: 0.8358 MB / 0.574 GB, free: 15.79 MB / 0.4948 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.002094/0.1545, allocations: 1.142 MB / 0.5751 GB, free: 14.55 MB / 0.4948 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02426/0.1787, allocations: 7.586 MB / 0.5825 GB, free: 6.859 MB / 0.4948 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.171e-05/0.1788, allocations: 4 kB / 0.5825 GB, free: 6.855 MB / 0.4948 GB Notification: Performance of matching and sorting (n=275) (initialization): time 0.006819/0.1856, allocations: 2.758 MB / 0.5852 GB, free: 4.086 MB / 0.4948 GB Notification: Performance of prepare postOptimizeDAE: time 2.962e-05/0.1856, allocations: 11.98 kB / 0.5852 GB, free: 4.074 MB / 0.4948 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.017e-05/0.1856, allocations: 8.125 kB / 0.5852 GB, free: 4.066 MB / 0.4948 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0006149/0.1862, allocations: 296.9 kB / 0.5855 GB, free: 3.773 MB / 0.4948 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00356/0.1898, allocations: 499.2 kB / 0.586 GB, free: 3.285 MB / 0.4948 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00496/0.1948, allocations: 2.748 MB / 0.5887 GB, free: 448 kB / 0.4948 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001886/0.1967, allocations: 155 kB / 0.5888 GB, free: 292 kB / 0.4948 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001953/0.1968, allocations: 79.98 kB / 0.5889 GB, free: 212 kB / 0.4948 GB Warning: Assuming fixed start value for the following 28 variables: DynGFMDroop.Converter.RLTransformer.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = DynGFMDroop.Converter.RLTransformer.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) DynGFMDroop.Converter.RLCFilter.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = DynGFMDroop.Converter.RLCFilter.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) Z2_Line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Z2_Line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) Z1_Line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Z1_Line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) DynGFMDroop.Converter.injectorURI.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = DynGFMDroop.Converter.injectorURI.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) DynGFMDroop.Converter.injectorURI.running:DISCRETE(flow=false start = DynGFMDroop.Converter.injectorURI.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean DynGFMDroop.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = DynGFMDroop.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) DynGFMDroop.running:DISCRETE(flow=false start = DynGFMDroop.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean Z1_Line.running:DISCRETE(flow=false start = Z1_Line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean Z2_Line.running:DISCRETE(flow=false start = Z2_Line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean DynGFMDroop.Measurements.firstOrder1.y:VARIABLE(flow=false start = DynGFMDroop.ControlDroop.QSEM.UqPcc0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Measurements.firstOrder.y:VARIABLE(flow=false start = DynGFMDroop.ControlDroop.QSEM.UdPcc0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Measurements.firstOrder2.y:VARIABLE(flow=false start = DynGFMDroop.Measurements.IdPcc0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Measurements.firstOrder21.y:VARIABLE(flow=false start = DynGFMDroop.Measurements.IqPcc0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Converter.VSC.firstOrder.y:VARIABLE(flow=false start = DynGFMDroop.Converter.VSC.UdConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Converter.VSC.firstOrder1.y:VARIABLE(flow=false start = DynGFMDroop.Converter.VSC.UqConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.Converter.RLCFilter.running:DISCRETE(flow=false start = DynGFMDroop.Converter.RLCFilter.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean DynGFMDroop.Converter.RLCFilter.terminal1.i.re:VARIABLE(flow=true start = DynGFMDroop.Converter.RLCFilter.iConv0Pu.re unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real DynGFMDroop.Converter.RLCFilter.terminal1.i.im:VARIABLE(flow=true start = DynGFMDroop.Converter.RLCFilter.iConv0Pu.im unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real DynGFMDroop.Converter.RLCFilter.terminal2.V.re:VARIABLE(flow=false start = DynGFMDroop.Converter.RLTransformer.uFilter0Pu.re unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real DynGFMDroop.Converter.RLCFilter.terminal2.V.im:VARIABLE(flow=false start = DynGFMDroop.Converter.RLTransformer.uFilter0Pu.im unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real DynGFMDroop.Converter.RLTransformer.running:DISCRETE(flow=false start = DynGFMDroop.Converter.RLTransformer.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean DynGFMDroop.Converter.RLTransformer.terminal1.i.re:VARIABLE(flow=true start = -DynGFMDroop.Converter.RLCFilter.iPcc0Pu.re unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real DynGFMDroop.Converter.RLTransformer.terminal1.i.im:VARIABLE(flow=true start = -DynGFMDroop.Converter.RLCFilter.iPcc0Pu.im unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real DynGFMDroop.ControlDroop.VI.virtualImpedanceActive:DISCRETE(start = DynGFMDroop.ControlDroop.VI.VIActive0 fixed = true ) \"True while the virtual impedance correction is active (above IMaxVI+HysteresisPu)\" type: Boolean DynGFMDroop.ControlDroop.droopControl.firstOrder1.y:VARIABLE(flow=false start = DynGFMDroop.ControlDroop.droopControl.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.ControlDroop.droopControl.firstOrder2.y:VARIABLE(flow=false start = DynGFMDroop.ControlDroop.droopControl.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real DynGFMDroop.ControlDroop.droopControl.firstOrder3.y:VARIABLE(flow=false start = DynGFMDroop.ControlDroop.droopControl.firstOrder3.y_start fixed = true ) \"Connector of Real output signal\" type: Real Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 31 * Number of states: 0 () * Number of discrete variables: 65 ($PRE.DynGFMDroop.Converter.RLTransformer.state,DynGFMDroop.Converter.RLTransformer.state,$PRE.DynGFMDroop.Converter.RLCFilter.state,DynGFMDroop.Converter.RLCFilter.state,$PRE.Z2_Line.state,Z2_Line.state,$PRE.Z1_Line.state,Z1_Line.state,$PRE.DynGFMDroop.Converter.injectorURI.state,DynGFMDroop.Converter.injectorURI.state,$PRE.DynGFMDroop.Converter.injectorURI.running,DynGFMDroop.Converter.injectorURI.running,$whenCondition5,$whenCondition4,$whenCondition6,$PRE.DynGFMDroop.state,DynGFMDroop.state,$PRE.DynGFMDroop.running,DynGFMDroop.running,$whenCondition2,$whenCondition1,$whenCondition3,$PRE.Z1_Line.running,$PRE.Z2_Line.running,$PRE.DynGFMDroop.Converter.RLCFilter.running,$PRE.DynGFMDroop.Converter.RLTransformer.running,$PRE.DynGFMDroop.ControlDroop.VI.virtualImpedanceActive,DynGFMDroop.ControlDroop.VI.virtualImpedanceActive,DynGFMDroop.Converter.RLTransformer.running,DynGFMDroop.Converter.RLCFilter.running,Z2_Line.running,Z2_Line.switchOffSignal2,Z1_Line.running,$whenCondition8,$whenCondition7,$whenCondition9,$whenCondition11,$whenCondition10,$whenCondition13,$whenCondition12,$whenCondition15,$whenCondition14,$whenCondition16,$whenCondition18,$whenCondition17,$whenCondition19,$whenCondition21,$whenCondition20,Z1_Line.switchOffSignal2,Z1_Line.switchOffSignal1,DynGFMDroop.Converter.RLTransformer.switchOffSignal2,DynGFMDroop.Converter.RLTransformer.switchOffSignal1,DynGFMDroop.Converter.RLCFilter.switchOffSignal2,DynGFMDroop.Converter.RLCFilter.switchOffSignal1,DynGFMDroop.Converter.injectorURI.switchOffSignal3,DynGFMDroop.Converter.injectorURI.switchOffSignal2,DynGFMDroop.Converter.injectorURI.switchOffSignal1,DynGFMDroop.switchOffSignal3,DynGFMDroop.switchOffSignal2,DynGFMDroop.switchOffSignal1,DynGFMDroop.ControlDroop.currentLoop.integratorq.local_reset,DynGFMDroop.ControlDroop.currentLoop.integratord.local_reset,DynGFMDroop.ControlDroop.pll.limIntegrator.local_reset,DynGFMDroop.ControlDroop.pll.integrator.local_reset,DynGFMDroop.ControlDroop.droopControl.integrator.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (266): * Single equations (assignments): 265 * Array equations: 0 * Algorithm blocks: 0 * 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,56.2%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.001468/0.1983, allocations: 0.6718 MB / 0.5895 GB, free: 15.54 MB / 0.5105 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005173/0.1988, allocations: 210.7 kB / 0.5897 GB, free: 15.33 MB / 0.5105 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005668/0.2045, allocations: 2.281 MB / 0.592 GB, free: 13.04 MB / 0.5105 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.968e-05/0.2045, allocations: 16 kB / 0.592 GB, free: 13.02 MB / 0.5105 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.279e-05/0.2045, allocations: 8.078 kB / 0.592 GB, free: 13.01 MB / 0.5105 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.942e-05/0.2046, allocations: 11.91 kB / 0.592 GB, free: 13 MB / 0.5105 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009703/0.2143, allocations: 4.633 MB / 0.5965 GB, free: 8.324 MB / 0.5105 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.593e-06/0.2143, allocations: 0 / 0.5965 GB, free: 8.324 MB / 0.5105 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003195/0.2175, allocations: 355.5 kB / 0.5969 GB, free: 7.977 MB / 0.5105 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0005452/0.218, allocations: 292.7 kB / 0.5971 GB, free: 7.688 MB / 0.5105 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001624/0.2182, allocations: 47.97 kB / 0.5972 GB, free: 7.641 MB / 0.5105 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01224/0.2304, allocations: 10.74 MB / 0.6077 GB, free: 12.2 MB / 0.5261 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.883e-06/0.2304, allocations: 0 / 0.6077 GB, free: 12.2 MB / 0.5261 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008165/0.2386, allocations: 3.602 MB / 0.6112 GB, free: 8.574 MB / 0.5261 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0007446/0.2393, allocations: 294.4 kB / 0.6115 GB, free: 8.285 MB / 0.5261 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003017/0.2396, allocations: 51.98 kB / 0.6115 GB, free: 8.234 MB / 0.5261 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001264/0.2409, allocations: 63.95 kB / 0.6116 GB, free: 8.172 MB / 0.5261 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004317/0.2413, allocations: 145.7 kB / 0.6117 GB, free: 8.027 MB / 0.5261 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001492/0.2415, allocations: 63.97 kB / 0.6118 GB, free: 7.965 MB / 0.5261 GB Notification: Performance of sorting global known variables: time 0.002053/0.2435, allocations: 1.201 MB / 0.613 GB, free: 6.77 MB / 0.5261 GB Notification: Performance of sort global known variables: time 8e-08/0.2435, allocations: 0 / 0.613 GB, free: 6.77 MB / 0.5261 GB Notification: Performance of remove unused functions: time 0.001847/0.2454, allocations: 0.5809 MB / 0.6135 GB, free: 6.188 MB / 0.5261 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 22 (DynGFMDroop.Measurements.firstOrder1.y,DynGFMDroop.Measurements.firstOrder.y,DynGFMDroop.Measurements.firstOrder2.y,DynGFMDroop.Measurements.firstOrder21.y,DynGFMDroop.Converter.VSC.firstOrder.y,DynGFMDroop.Converter.VSC.firstOrder1.y,DynGFMDroop.Converter.RLCFilter.terminal1.i.re,DynGFMDroop.Converter.RLCFilter.terminal1.i.im,DynGFMDroop.Converter.RLCFilter.terminal2.V.re,DynGFMDroop.Converter.RLCFilter.terminal2.V.im,DynGFMDroop.Converter.RLTransformer.terminal1.i.re,DynGFMDroop.Converter.RLTransformer.terminal1.i.im,DynGFMDroop.ControlDroop.PLLFilter.y,DynGFMDroop.ControlDroop.droopControl.firstOrder.y,DynGFMDroop.ControlDroop.droopControl.integrator.y,DynGFMDroop.ControlDroop.droopControl.firstOrder1.y,DynGFMDroop.ControlDroop.droopControl.firstOrder2.y,DynGFMDroop.ControlDroop.droopControl.firstOrder3.y,DynGFMDroop.ControlDroop.pll.integrator.y,DynGFMDroop.ControlDroop.pll.limIntegrator.y,DynGFMDroop.ControlDroop.currentLoop.integratord.y,DynGFMDroop.ControlDroop.currentLoop.integratorq.y) * Number of discrete variables: 35 ($whenCondition3,$whenCondition1,$whenCondition2,DynGFMDroop.running,DynGFMDroop.state,$whenCondition6,$whenCondition4,$whenCondition5,DynGFMDroop.Converter.injectorURI.running,DynGFMDroop.Converter.injectorURI.state,$whenCondition20,$whenCondition21,$whenCondition19,$whenCondition17,$whenCondition18,$whenCondition16,$whenCondition14,$whenCondition15,$whenCondition12,$whenCondition13,$whenCondition10,$whenCondition11,$whenCondition9,$whenCondition7,$whenCondition8,Z1_Line.running,Z1_Line.state,Z2_Line.switchOffSignal2,Z2_Line.running,Z2_Line.state,DynGFMDroop.Converter.RLCFilter.running,DynGFMDroop.Converter.RLCFilter.state,DynGFMDroop.Converter.RLTransformer.running,DynGFMDroop.Converter.RLTransformer.state,DynGFMDroop.ControlDroop.VI.virtualImpedanceActive) * Number of discrete states: 6 (DynGFMDroop.Converter.RLTransformer.running,DynGFMDroop.Converter.RLCFilter.running,Z1_Line.running,Z2_Line.running,DynGFMDroop.Converter.injectorURI.running,DynGFMDroop.running) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (173): * Single equations (assignments): 153 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 13 * If-equations: 0 * Equation systems (not torn): 6 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 6 systems {1, 1, 1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(8,2,56.2%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.0005443/0.2459, allocations: 229.3 kB / 0.6137 GB, free: 5.957 MB / 0.5261 GB Notification: Performance of simCode: created initialization part: time 0.004914/0.2508, allocations: 2.184 MB / 0.6159 GB, free: 3.762 MB / 0.5261 GB Notification: Performance of simCode: created event and clocks part: time 3.487e-06/0.2508, allocations: 3.938 kB / 0.6159 GB, free: 3.758 MB / 0.5261 GB Notification: Performance of simCode: created simulation system equations: time 0.003977/0.2548, allocations: 1.213 MB / 0.6171 GB, free: 2.531 MB / 0.5261 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001903/0.2567, allocations: 382.2 kB / 0.6174 GB, free: 2.172 MB / 0.5261 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008032/0.2647, allocations: 4.129 MB / 0.6215 GB, free: 14 MB / 0.5417 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00127/0.266, allocations: 0.8905 MB / 0.6223 GB, free: 13.07 MB / 0.5417 GB Notification: Performance of simCode: alias equations: time 0.001003/0.267, allocations: 214.2 kB / 0.6225 GB, free: 12.86 MB / 0.5417 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005994/0.2676, allocations: 144.5 kB / 0.6227 GB, free: 12.71 MB / 0.5417 GB Notification: Performance of SimCode: time 8.41e-07/0.2676, allocations: 4 kB / 0.6227 GB, free: 12.71 MB / 0.5417 GB Notification: Performance of Templates: time 0.05606/0.3237, allocations: 29.69 MB / 0.6517 GB, free: 15.17 MB / 0.573 GB " [Timeout remaining time 660] make -j1 -f Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.makefile [Timeout 660] (rm -f Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.pipe >> ../files/Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.sim & ./Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown -lv=LOG_STDOUT,LOG_ASSERT,LOG_STATS -s=dassl -variableFilter=.* -abortSlowSimulation -alarm=240 -emit_protected -ignoreHideResult -lv LOG_STATS > Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown.pipe 2>&1) [Timeout 240] diffSimulationResults("Dynawo_dev_Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.GridForming.Tests.SCRJump.DroopDown_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: 101.210342469858]