Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.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.0006319/0.0006319, allocations: 72.27 kB / 9.851 MB, free: 0.8477 MB / 10.45 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.0008799/0.001512, allocations: 447.7 kB / 10.29 MB, free: 420 kB / 10.45 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.8496/0.8496, allocations: 177.1 MB / 188.2 MB, free: 4.504 MB / 186.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.1405/0.9901, allocations: 53.65 MB / 241.8 MB, free: 2.746 MB / 234.7 MB
"
[Timeout remaining time 179]
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.0007397/0.0007397, allocations: 148.8 kB / 242.7 MB, free: 1.883 MB / 234.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.0009559/0.001696, allocations: 479.8 kB / 243.2 MB, free: 1.43 MB / 234.7 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo): time 0.4204/0.4204, allocations: 84.64 MB / 328.5 MB, free: 1.664 MB / 314.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.03669/0.4571, allocations: 28.74 MB / 357.3 MB, free: 8.816 MB / 346.7 MB
"
[Timeout remaining time 180]
Using package OpenIPSL with version 3.2.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/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 Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A",fmuType="me_cs",version="2.0+3.0",platforms={"static"})
"" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A",fmuType="me_cs",version="2.0+3.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 3.927e-06/3.927e-06, allocations: 0 / 472 MB, free: 3.637 MB / 458.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.148e-05/2.541e-05, allocations: 8.562 kB / 472 MB, free: 3.629 MB / 458.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A): time 0.007752/0.007777, allocations: 9.695 MB / 481.7 MB, free: 9.887 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.006322/0.0141, allocations: 3.928 MB / 485.6 MB, free: 5.949 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001355/0.01545, allocations: 139.5 kB / 485.7 MB, free: 5.812 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0009438/0.0164, allocations: 0.5463 MB / 486.3 MB, free: 5.262 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.002618/0.01902, allocations: 1.429 MB / 487.7 MB, free: 3.824 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002198/0.02121, allocations: 1.673 MB / 489.4 MB, free: 2.148 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003421/0.02463, allocations: 3.906 MB / 493.3 MB, free: 14.23 MB / 490.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007643/0.0254, allocations: 0.5243 MB / 493.8 MB, free: 13.64 MB / 490.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003589/0.02899, allocations: 2.958 MB / 496.8 MB, free: 10.64 MB / 490.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001579/0.03057, allocations: 1.472 MB / 498.2 MB, free: 9.16 MB / 490.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005935/0.03116, allocations: 320 kB / 498.5 MB, free: 8.848 MB / 490.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007556/0.03192, allocations: 499.7 kB / 499 MB, free: 8.359 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004219/0.03234, allocations: 0.6268 MB / 499.7 MB, free: 7.73 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006812/0.03302, allocations: 0.7325 MB / 0.4887 GB, free: 6.996 MB / 490.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002273/0.03529, allocations: 2.323 MB / 0.4909 GB, free: 4.66 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 3.848e-06/0.0353, allocations: 0 / 0.4909 GB, free: 4.66 MB / 490.7 MB
Notification: Performance of FrontEnd: time 1.052e-06/0.0353, allocations: 0 / 0.4909 GB, free: 4.66 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 2.381e-05/0.03532, allocations: 0 / 0.4909 GB, free: 4.66 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 386
 * Number of variables: 386
Notification: Performance of Generate backend data structure: time 0.1604/0.1957, allocations: 4.866 MB / 0.4957 GB, free: 129.4 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 2.867e-05/0.1958, allocations: 10.41 kB / 0.4957 GB, free: 129.4 MB / 490.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0004064/0.1962, allocations: 240.6 kB / 0.4959 GB, free: 129.3 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003993/0.2002, allocations: 1.074 MB / 0.497 GB, free: 129.3 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002542/0.2027, allocations: 1.396 MB / 0.4983 GB, free: 128.9 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004471/0.2031, allocations: 1.129 MB / 0.4994 GB, free: 127.7 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002654/0.2034, allocations: 178.5 kB / 0.4996 GB, free: 127.7 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001784/0.2052, allocations: 1.404 MB / 0.501 GB, free: 127.5 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.087e-05/0.2052, allocations: 1.109 kB / 0.501 GB, free: 127.5 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.165e-05/0.2053, allocations: 61.22 kB / 0.501 GB, free: 127.5 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.31e-05/0.2053, allocations: 37.47 kB / 0.5011 GB, free: 127.5 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001012/0.2063, allocations: 0.6152 MB / 0.5017 GB, free: 127.4 MB / 490.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.005392/0.2117, allocations: 3.954 MB / 0.5055 GB, free: 126.6 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002724/0.2145, allocations: 1.78 MB / 0.5073 GB, free: 126.4 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004343/0.2149, allocations: 369.4 kB / 0.5076 GB, free: 126.4 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001009/0.215, allocations: 39.62 kB / 0.5077 GB, free: 126.4 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0006741/0.2157, allocations: 0.7644 MB / 0.5084 GB, free: 126.3 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=180): time 3.868e-06/0.2157, allocations: 0 / 0.5084 GB, free: 126.3 MB / 490.7 MB
Notification: Performance of matching and sorting (n=180): time 0.01495/0.2306, allocations: 7.552 MB / 0.5158 GB, free: 120.8 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.523e-05/0.2307, allocations: 197.9 kB / 0.516 GB, free: 120.6 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00133/0.232, allocations: 1.871 MB / 0.5178 GB, free: 119.1 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001669/0.2322, allocations: 64.83 kB / 0.5179 GB, free: 119.1 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002704/0.2324, allocations: 0.6624 MB / 0.5185 GB, free: 118.6 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004059/0.2328, allocations: 0.681 MB / 0.5192 GB, free: 118.1 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000448/0.2333, allocations: 464.8 kB / 0.5196 GB, free: 117.9 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 2.23e-05/0.2333, allocations: 303.3 kB / 0.5199 GB, free: 117.6 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007611/0.2341, allocations: 486.1 kB / 0.5204 GB, free: 117.1 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009649/0.235, allocations: 0.8317 MB / 0.5212 GB, free: 116.3 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002244/0.2373, allocations: 2.014 MB / 0.5232 GB, free: 114.5 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.855e-06/0.2373, allocations: 0.9844 kB / 0.5232 GB, free: 114.5 MB / 490.7 MB
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.simpleLagLim.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.simpleLagLim.y' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.simpleLagLim.y' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.TransducerDelay.state' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.TransducerDelay.state' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.TransducerDelay.state' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Notification: Performance of matching and sorting (n=325) (initialization): time 0.003313/0.2406, allocations: 2.396 MB / 0.5255 GB, free: 112.3 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.284e-05/0.2406, allocations: 8 kB / 0.5255 GB, free: 112.3 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.969e-06/0.2406, allocations: 4.859 kB / 0.5255 GB, free: 112.3 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003383/0.244, allocations: 2.017 MB / 0.5275 GB, free: 110.4 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001477/0.2455, allocations: 0.698 MB / 0.5282 GB, free: 109.8 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001865/0.2473, allocations: 1.698 MB / 0.5298 GB, free: 108.3 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001342/0.2487, allocations: 315.1 kB / 0.5301 GB, free: 108 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000125/0.2488, allocations: 62.3 kB / 0.5302 GB, free: 108 MB / 490.7 MB
Warning: Assuming fixed start value for the following 6 variables:
         pSS2A.rampTrackingFilter.TF1[1].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[1].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[2].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[2].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[3].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[3].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[4].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[4].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[5].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[5].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF2[1].x_scaled[1]:VARIABLE(fixed = true protected = true )  \"Scaled vector x\" type: Real [1,1]
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001138/0.25, allocations: 0.6275 MB / 0.5308 GB, free: 107.5 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007944/0.2507, allocations: 0.8221 MB / 0.5316 GB, free: 106.7 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002183/0.2529, allocations: 1.993 MB / 0.5335 GB, free: 104.7 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.025e-06/0.2529, allocations: 0 / 0.5335 GB, free: 104.7 MB / 490.7 MB
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.simpleLagLim.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.simpleLagLim.y' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.simpleLagLim.y' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.TransducerDelay.state' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.TransducerDelay.state' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.TransducerDelay.state' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Notification: Performance of matching and sorting (n=325) (initialization_lambda0): time 0.003053/0.256, allocations: 2.303 MB / 0.5358 GB, free: 102.4 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.378e-05/0.256, allocations: 8 kB / 0.5358 GB, free: 102.4 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.596e-06/0.256, allocations: 4 kB / 0.5358 GB, free: 102.4 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003262/0.2593, allocations: 1.943 MB / 0.5377 GB, free: 100.5 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001404/0.2607, allocations: 0.707 MB / 0.5384 GB, free: 99.83 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001689/0.2624, allocations: 1.63 MB / 0.54 GB, free: 98.23 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001193/0.2636, allocations: 266.7 kB / 0.5402 GB, free: 97.96 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001029/0.2637, allocations: 68.64 kB / 0.5403 GB, free: 97.9 MB / 490.7 MB
Warning: Assuming fixed start value for the following 6 variables:
         pSS2A.rampTrackingFilter.TF1[1].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[1].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[2].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[2].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[3].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[3].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[4].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[4].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF1[5].x_scaled[1]:VARIABLE(start = pSS2A.rampTrackingFilter.TF1[5].x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [5,1]
         pSS2A.rampTrackingFilter.TF2[1].x_scaled[1]:VARIABLE(fixed = true protected = true )  \"Scaled vector x\" type: Real [1,1]
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 22
 * Number of states: 0 ()
 * Number of discrete variables: 2 ($whenCondition2,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (233):
 * Single equations (assignments): 232
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(34,57)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003598/0.264, allocations: 339.1 kB / 0.5406 GB, free: 97.59 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002725/0.2643, allocations: 211.8 kB / 0.5408 GB, free: 97.39 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005062/0.2694, allocations: 3.236 MB / 0.544 GB, free: 94.18 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.011e-05/0.2694, allocations: 20 kB / 0.544 GB, free: 94.16 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.464e-06/0.2694, allocations: 0 / 0.544 GB, free: 94.16 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.431e-05/0.2694, allocations: 12.61 kB / 0.544 GB, free: 94.14 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006605/0.276, allocations: 4.633 MB / 0.5485 GB, free: 89.79 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.42e-06/0.276, allocations: 0 / 0.5485 GB, free: 89.79 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007353/0.2767, allocations: 273.7 kB / 0.5488 GB, free: 89.53 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004676/0.2814, allocations: 2.233 MB / 0.551 GB, free: 87.3 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001524/0.2816, allocations: 51.97 kB / 0.551 GB, free: 87.25 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007426/0.289, allocations: 5.945 MB / 0.5568 GB, free: 81.25 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.535e-06/0.289, allocations: 3.984 kB / 0.5568 GB, free: 81.24 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007702/0.2967, allocations: 3.691 MB / 0.5604 GB, free: 77.61 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005249/0.2972, allocations: 298.7 kB / 0.5607 GB, free: 77.31 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000276/0.2975, allocations: 44 kB / 0.5608 GB, free: 77.27 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001042/0.2985, allocations: 143.9 kB / 0.5609 GB, free: 77.13 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005785/0.2991, allocations: 293.9 kB / 0.5612 GB, free: 76.84 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001013/0.2992, allocations: 35.98 kB / 0.5612 GB, free: 76.8 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.0008846/0.3001, allocations: 1.002 MB / 0.5622 GB, free: 75.91 MB / 490.7 MB
Notification: Performance of sort global known variables: time 1.6e-07/0.3001, allocations: 0 / 0.5622 GB, free: 75.91 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.001976/0.3021, allocations: 1.163 MB / 0.5633 GB, free: 74.74 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 28 (gENCLS.omega,gENCLS.delta,gENCLS.eq,gENROE.w,gENROE.delta,gENROE.Epd,gENROE.Epq,gENROE.PSIkd,gENROE.PSIkq,eSST1A.imDerivativeLag.x,eSST1A.imLeadLag.TF.x_scaled[1],eSST1A.imLeadLag1.TF.x_scaled[1],eSST1A.simpleLagLim.state,eSST1A.TransducerDelay.state,pSS2A.Leadlag1.TF.x_scaled[1],pSS2A.Leadlag2.TF.x_scaled[1],pSS2A.SimpleLag1.state,pSS2A.SimpleLag2.state,pSS2A.rampTrackingFilter.TF1[1].x_scaled[1],pSS2A.rampTrackingFilter.TF1[2].x_scaled[1],pSS2A.rampTrackingFilter.TF1[3].x_scaled[1],pSS2A.rampTrackingFilter.TF1[4].x_scaled[1],pSS2A.rampTrackingFilter.TF1[5].x_scaled[1],pSS2A.rampTrackingFilter.TF2[1].x_scaled[1],pSS2A.derivativeLag.TF.x_scaled[1],pSS2A.derivativeLag1.TF.x_scaled[1],pSS2A.derivativeLag2.TF.x_scaled[1],pSS2A.derivativeLag3.TF.x_scaled[1])
 * Number of discrete variables: 2 ($whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (128):
 * Single equations (assignments): 126
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,9), (26,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.007638/0.3097, allocations: 4.25 MB / 0.5675 GB, free: 70.55 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.007264/0.317, allocations: 3.388 MB / 0.5708 GB, free: 67.27 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 3.448e-05/0.317, allocations: 24 kB / 0.5708 GB, free: 67.25 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.002822/0.3198, allocations: 1.54 MB / 0.5723 GB, free: 65.74 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00166/0.3215, allocations: 380.7 kB / 0.5727 GB, free: 65.38 MB / 490.7 MB
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.simpleLagLim.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.simpleLagLim.y' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.simpleLagLim.y' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Warning: Initialization start-value cycle: the start attribute of 'eSST1A.TransducerDelay.state' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'eSST1A.TransducerDelay.state' and therefore cannot be computed from it, so this start value cannot be used to initialize the variable (see Modelica Specification section 4.9.6). This is possibly a modeling error; if unintended, give 'eSST1A.TransducerDelay.state' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02229/0.3438, allocations: 16.41 MB / 0.5887 GB, free: 49.42 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003599/0.3441, allocations: 0.4996 MB / 0.5892 GB, free: 48.9 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.0009815/0.3451, allocations: 281.2 kB / 0.5895 GB, free: 48.62 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001386/0.3465, allocations: 1.299 MB / 0.5907 GB, free: 47.32 MB / 490.7 MB
Notification: Performance of SimCode: time 1.243e-06/0.3465, allocations: 0 / 0.5907 GB, free: 47.32 MB / 490.7 MB
Notification: Evaluated the parameters pSS2A.Leadlag2.K, pSS2A.Leadlag2.T2, pSS2A.Leadlag2.T1, pSS2A.Leadlag1.K, pSS2A.Leadlag1.T2, pSS2A.Leadlag1.T1, pSS2A.rampTrackingFilter.TF1.d, since an equation would be solved by dividing by zero otherwise. Changing them requires recompiling the model.
Notification: FMU-only work: backend 0.007338, simCode 0.01536, templates 0
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1564/0.5029, allocations: 88.44 MB / 0.6771 GB, free: 7.133 MB / 0.5261 GB
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.2/3.703, allocations: 22.22 kB / 0.6771 GB, free: 7.113 MB / 0.5261 GB
"
[Timeout remaining time 656]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_fmu --startTime=0 --stopTime=10 --stepSize=0.004 --mode=me --timeout=240 --tolerance=1e-06 ../OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A.fmu) > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe 2>&1) [Timeout 252.0]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-cvode.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-cvode.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-cvode.sim & (cd run_OMSimulator-cs-cvode && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_OMSimulator-cs-cvode_fmu --startTime=0 --stopTime=10 --stepSize=0.004 --mode=cs --timeout=240 --tolerance=1e-06 ../OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_OMSimulator-cs-cvode.fmu) > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-cvode.pipe 2>&1) [Timeout 252.0]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-euler.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-euler.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-euler.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-euler.sim & (cd run_OMSimulator-cs-euler && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_OMSimulator-cs-euler_fmu --startTime=0 --stopTime=10 --stepSize=0.004 --mode=cs --timeout=240 --tolerance=1e-06 ../OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_OMSimulator-cs-euler.fmu) > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_OMSimulator-cs-euler.pipe 2>&1) [Timeout 252.0]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy_res.csv --start-time 0 --stop-time 10 --timeout 240 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.004 ../OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A.fmu) > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy.pipe 2>&1) [Timeout 252.0]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode.sim & (cd run_fmpy-fmi3-cs-cvode && python3 -m fmpy simulate --output-file ../OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode_res.csv --start-time 0 --stop-time 10 --timeout 240 --relative-tolerance 1e-06 --interface-type CoSimulation --output-interval 0.004 ../OpenIPSL_dev_OpenIPSL_Tests_Controls_PSSE_PSS_PSS2A_fmpy-fmi3-cs-cvode.fmu) > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A_fmpy-fmi3-cs-cvode.pipe 2>&1) [Timeout 252.0]
[Calling sys.exit(0), Time elapsed: 8.219790196977556]