Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.05502/0.05502, allocations: 9.517 MB / 29.3 MB, free: 160 kB / 18.57 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
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.001483/0.001483, allocations: 95.36 kB / 35.47 MB, free: 0.5898 MB / 24.77 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[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.9964/0.9964, allocations: 158.6 MB / 200.2 MB, free: 7.035 MB / 186.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[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.002171/0.002171, allocations: 160.5 kB / 255.5 MB, free: 15.61 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.1956/0.1956, allocations: 59.7 MB / 370.4 MB, free: 12.32 MB / 298.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo)
Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.ES.URST5T,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T")
translateModel(OpenIPSL.Tests.Controls.PSSE.ES.URST5T,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.302e-06/1.302e-06, allocations: 2.812 kB / 460.5 MB, free: 37.66 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 9.137e-06/1.044e-05, allocations: 2.312 kB / 460.5 MB, free: 37.66 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.ES.URST5T): time 0.005395/0.005405, allocations: 8.105 MB / 468.6 MB, free: 32.23 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.003875/0.00928, allocations: 2.745 MB / 471.3 MB, free: 30.34 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005426/0.009823, allocations: 24.03 kB / 471.3 MB, free: 30.33 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0004457/0.01027, allocations: 334.1 kB / 471.7 MB, free: 30.14 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.001808/0.01208, allocations: 1.28 MB / 473 MB, free: 29.32 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001203/0.01328, allocations: 0.8824 MB / 473.8 MB, free: 28.86 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.001877/0.01516, allocations: 2.581 MB / 476.4 MB, free: 27.59 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004144/0.01557, allocations: 366.4 kB / 476.8 MB, free: 27.37 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001091/0.01666, allocations: 1.363 MB / 478.1 MB, free: 26.72 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009274/0.01759, allocations: 0.9591 MB / 479.1 MB, free: 26.39 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002809/0.01787, allocations: 210.5 kB / 479.3 MB, free: 26.39 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005266/0.0184, allocations: 395.8 kB / 479.7 MB, free: 26.34 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002808/0.01868, allocations: 0.5121 MB / 480.2 MB, free: 25.99 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005313/0.01921, allocations: 0.6913 MB / 480.9 MB, free: 25.62 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001526/0.02073, allocations: 1.811 MB / 482.7 MB, free: 24.68 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.824e-06/0.02074, allocations: 1.188 kB / 482.7 MB, free: 24.68 MB / 362.7 MB
Notification: Performance of FrontEnd: time 7.11e-07/0.02074, allocations: 1.344 kB / 482.7 MB, free: 24.68 MB / 362.7 MB
Notification: Performance of Transformations before backend: time 2.078e-05/0.02076, allocations: 0 / 482.7 MB, free: 24.68 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: 289
 * Number of variables: 289
Notification: Performance of Generate backend data structure: time 0.006412/0.02717, allocations: 4.203 MB / 486.9 MB, free: 22.5 MB / 362.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.401e-05/0.0272, allocations: 9.625 kB / 486.9 MB, free: 22.5 MB / 362.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00228/0.02948, allocations: 0.9585 MB / 487.9 MB, free: 21.88 MB / 362.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008718/0.03036, allocations: 1.119 MB / 489 MB, free: 20.72 MB / 362.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001851/0.03054, allocations: 0.5734 MB / 489.6 MB, free: 20.04 MB / 362.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000134/0.03068, allocations: 128 kB / 489.7 MB, free: 19.92 MB / 362.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009744/0.03165, allocations: 1.118 MB / 490.8 MB, free: 18.7 MB / 362.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.846e-05/0.03167, allocations: 0 / 490.8 MB, free: 18.7 MB / 362.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.892e-05/0.03175, allocations: 51.94 kB / 490.9 MB, free: 18.65 MB / 362.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.206e-05/0.03176, allocations: 28 kB / 490.9 MB, free: 18.62 MB / 362.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006556/0.03241, allocations: 0.5544 MB / 491.4 MB, free: 18.05 MB / 362.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.003672/0.03609, allocations: 4.226 MB / 495.7 MB, free: 13.73 MB / 362.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002292/0.03838, allocations: 1.422 MB / 497.1 MB, free: 12.27 MB / 362.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006544/0.03903, allocations: 367.4 kB / 497.5 MB, free: 11.9 MB / 362.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001145/0.03915, allocations: 45.2 kB / 497.5 MB, free: 11.86 MB / 362.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0006619/0.03981, allocations: 0.6238 MB / 498.1 MB, free: 11.2 MB / 362.7 MB
Notification: Performance of pre-optimization done (n=139): time 3.336e-06/0.03981, allocations: 0 / 498.1 MB, free: 11.2 MB / 362.7 MB
Notification: Performance of matching and sorting (n=139): time 0.02004/0.05985, allocations: 6.665 MB / 0.493 GB, free: 4.52 MB / 362.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.292e-05/0.05993, allocations: 197.2 kB / 0.4931 GB, free: 4.285 MB / 362.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001759/0.06169, allocations: 1.265 MB / 0.4944 GB, free: 2.996 MB / 362.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0004592/0.06214, allocations: 57.7 kB / 0.4944 GB, free: 2.934 MB / 362.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000483/0.06263, allocations: 0.7571 MB / 0.4952 GB, free: 2.168 MB / 362.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005638/0.06319, allocations: 0.5228 MB / 0.4957 GB, free: 1.641 MB / 362.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006204/0.06381, allocations: 389 kB / 0.4961 GB, free: 1.254 MB / 362.7 MB
Notification: Performance of setup shared object (initialization): time 5.033e-05/0.06386, allocations: 480.7 kB / 0.4965 GB, free: 0.7812 MB / 362.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000891/0.06475, allocations: 447.3 kB / 0.4969 GB, free: 348 kB / 362.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001165/0.06592, allocations: 0.8121 MB / 0.4977 GB, free: 15.41 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002135/0.06805, allocations: 1.208 MB / 0.4989 GB, free: 14.13 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.175e-05/0.06806, allocations: 4 kB / 0.4989 GB, free: 14.12 MB / 378.7 MB
Notification: Performance of matching and sorting (n=253) (initialization): time 0.00748/0.07554, allocations: 3.004 MB / 0.5018 GB, free: 11.11 MB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.715e-05/0.07557, allocations: 12 kB / 0.5019 GB, free: 11.09 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.662e-05/0.07559, allocations: 4 kB / 0.5019 GB, free: 11.09 MB / 378.7 MB
Warning: Initialization start-value cycle: the start attribute of 'uRST5T.TransducerDelay.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.TransducerDelay.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 'uRST5T.TransducerDelay.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 'uRST5T.TransducerDelay.state' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.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 'uRST5T.TransducerDelay.state' 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 'uRST5T.LL1.integrator.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.LL1.integrator.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 'uRST5T.LL1.integrator.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 'uRST5T.LL2.integrator.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.LL2.integrator.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 'uRST5T.LL2.integrator.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 'uRST5T.simpleLagLimVar.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.simpleLagLimVar.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 'uRST5T.simpleLagLimVar.y' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Notification: Performance of postOpt tearingSystem (initialization): time 0.00657/0.08216, allocations: 2.434 MB / 0.5042 GB, free: 8.66 MB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001171/0.08333, allocations: 264.6 kB / 0.5045 GB, free: 8.402 MB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004337/0.08767, allocations: 2.206 MB / 0.5066 GB, free: 6.172 MB / 378.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002121/0.08979, allocations: 230.8 kB / 0.5069 GB, free: 5.945 MB / 378.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002639/0.09005, allocations: 51.98 kB / 0.5069 GB, free: 5.895 MB / 378.7 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001485/0.09154, allocations: 0.5807 MB / 0.5075 GB, free: 5.309 MB / 378.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001214/0.09275, allocations: 0.8121 MB / 0.5083 GB, free: 4.387 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002224/0.09498, allocations: 1.204 MB / 0.5095 GB, free: 3.105 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.175e-05/0.09499, allocations: 4 kB / 0.5095 GB, free: 3.102 MB / 378.7 MB
Notification: Performance of matching and sorting (n=253) (initialization_lambda0): time 0.007716/0.1027, allocations: 2.988 MB / 0.5124 GB, free: 100 kB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.676e-05/0.1027, allocations: 4 kB / 0.5124 GB, free: 96 kB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.654e-05/0.1027, allocations: 8 kB / 0.5124 GB, free: 88 kB / 378.7 MB
Warning: Initialization start-value cycle: the start attribute of 'uRST5T.TransducerDelay.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.TransducerDelay.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 'uRST5T.TransducerDelay.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 'uRST5T.TransducerDelay.state' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.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 'uRST5T.TransducerDelay.state' 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 'uRST5T.LL1.integrator.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.LL1.integrator.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 'uRST5T.LL1.integrator.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 'uRST5T.LL2.integrator.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.LL2.integrator.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 'uRST5T.LL2.integrator.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 'uRST5T.simpleLagLimVar.y' depends, directly or transitively, on the variable itself. The start attribute defines the initial value of 'uRST5T.simpleLagLimVar.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 'uRST5T.simpleLagLimVar.y' a start value that does not depend on itself. Use the transformational debugger to inspect the dependency chain.
Notification: Performance of postOpt tearingSystem (initialization): time 0.00585/0.1086, allocations: 2.425 MB / 0.5148 GB, free: 13.66 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008328/0.1094, allocations: 271.1 kB / 0.515 GB, free: 13.4 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002715/0.1121, allocations: 2.141 MB / 0.5171 GB, free: 11.22 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001169/0.1133, allocations: 215 kB / 0.5173 GB, free: 11.01 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.433e-05/0.1134, allocations: 51.98 kB / 0.5174 GB, free: 10.96 MB / 394.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 19
 * Number of states: 0 ()
 * Number of discrete variables: 3 (uRST5T.LL1.integrator.local_reset,uRST5T.LL2.integrator.local_reset,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (156):
 * Single equations (assignments): 155
 * 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
   {(36,62)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003883/0.1138, allocations: 355.8 kB / 0.5177 GB, free: 10.6 MB / 394.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00026/0.1141, allocations: 222.8 kB / 0.5179 GB, free: 10.38 MB / 394.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005632/0.1197, allocations: 3.09 MB / 0.5209 GB, free: 7.266 MB / 394.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.08e-05/0.1197, allocations: 16 kB / 0.5209 GB, free: 7.25 MB / 394.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.014e-06/0.1197, allocations: 3.938 kB / 0.5209 GB, free: 7.246 MB / 394.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.281e-05/0.1197, allocations: 11.97 kB / 0.521 GB, free: 7.234 MB / 394.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0071/0.1268, allocations: 4.31 MB / 0.5252 GB, free: 2.871 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.298e-06/0.1268, allocations: 0 / 0.5252 GB, free: 2.871 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004343/0.1273, allocations: 175.8 kB / 0.5253 GB, free: 2.699 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004872/0.1321, allocations: 2.129 MB / 0.5274 GB, free: 0.5664 MB / 394.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.468e-05/0.1322, allocations: 35.92 kB / 0.5274 GB, free: 0.5312 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007525/0.1397, allocations: 5.096 MB / 0.5324 GB, free: 11.32 MB / 410.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.635e-06/0.1397, allocations: 1.062 kB / 0.5324 GB, free: 11.32 MB / 410.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006037/0.1458, allocations: 3.563 MB / 0.5359 GB, free: 7.715 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003254/0.1461, allocations: 230.3 kB / 0.5361 GB, free: 7.488 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000151/0.1462, allocations: 28 kB / 0.5362 GB, free: 7.461 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000638/0.1469, allocations: 103.9 kB / 0.5363 GB, free: 7.359 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003764/0.1473, allocations: 265.3 kB / 0.5365 GB, free: 7.102 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.895e-05/0.1473, allocations: 27.98 kB / 0.5365 GB, free: 7.074 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.0005846/0.1479, allocations: 0.7448 MB / 0.5373 GB, free: 6.332 MB / 410.7 MB
Notification: Performance of sort global known variables: time 7e-08/0.1479, allocations: 0 / 0.5373 GB, free: 6.332 MB / 410.7 MB
Notification: Performance of remove unused functions: time 0.001496/0.1494, allocations: 0.9246 MB / 0.5382 GB, free: 5.406 MB / 410.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 13 (gENCLS.omega,uRST5T.TransducerDelay.state,uRST5T.simpleLagLimVar.state,uRST5T.LL2.integrator.y,uRST5T.LL1.integrator.y,gENROU.PSIkq,gENROU.PSIkd,gENROU.Epq,gENROU.Epd,gENROU.delta,gENROU.w,gENCLS.eq,gENCLS.delta)
 * Number of discrete variables: 1 ($whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (96):
 * Single equations (assignments): 95
 * 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
   {(26,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0002522/0.1496, allocations: 155 kB / 0.5383 GB, free: 5.242 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.006/0.1556, allocations: 3.277 MB / 0.5415 GB, free: 1.969 MB / 410.7 MB
Notification: Performance of simCode: created event and clocks part: time 4.238e-06/0.1557, allocations: 4 kB / 0.5415 GB, free: 1.965 MB / 410.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.002121/0.1578, allocations: 1.39 MB / 0.5429 GB, free: 0.5469 MB / 410.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0006816/0.1585, allocations: 203.8 kB / 0.5431 GB, free: 360 kB / 410.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003434/0.1619, allocations: 2.945 MB / 0.5459 GB, free: 13.37 MB / 426.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005128/0.1624, allocations: 305.5 kB / 0.5462 GB, free: 13.05 MB / 426.7 MB
Notification: Performance of simCode: alias equations: time 0.000404/0.1628, allocations: 170.8 kB / 0.5464 GB, free: 12.88 MB / 426.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004394/0.1632, allocations: 274.1 kB / 0.5467 GB, free: 12.61 MB / 426.7 MB
Notification: Performance of SimCode: time 7.21e-07/0.1632, allocations: 0 / 0.5467 GB, free: 12.61 MB / 426.7 MB
Notification: Performance of Templates: time 0.04299/0.2062, allocations: 42.57 MB / 0.5882 GB, free: 2.219 MB / 458.7 MB
"
[Timeout remaining time 660]
make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.makefile [Timeout 660]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.sim & ./OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T -abortSlowSimulation -alarm=240  -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.URST5T.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.389785810839385]