Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.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.09832/0.09832, allocations: 12.36 MB / 31.21 MB, free: 6.438 MB / 26.18 MB
"
[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.00125/0.00125, allocations: 113 kB / 37.24 MB, free: 1.121 MB / 26.18 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.383/1.383, allocations: 207.7 MB / 250.9 MB, free: 7.281 MB / 190.1 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.001528/0.001528, allocations: 208.4 kB / 306.1 MB, free: 316 kB / 238.1 MB
"
[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.3217/0.3217, allocations: 79.72 MB / 440.9 MB, free: 12.28 MB / 318.1 MB
"
[Timeout remaining time 179]
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: "" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_TG_GGOV1",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_TG_GGOV1",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Modelica_Synchronous requested package ModelicaServices of version 3.2.3. ModelicaServices 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: OpenIPSL requested package Complex of version 3.2.3. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.004139/0.004139, allocations: 143.8 kB / 0.5875 GB, free: 9.332 MB / 398.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1226/0.1268, allocations: 71.96 MB / 0.6578 GB, free: 1.309 MB / 462.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1): time 0.2488/0.3755, allocations: 9.691 MB / 0.6673 GB, free: 5.277 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007292/0.3828, allocations: 3.894 MB / 0.6711 GB, free: 3.137 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001924/0.3848, allocations: 46.22 kB / 0.6711 GB, free: 3.117 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001172/0.3859, allocations: 443.5 kB / 0.6715 GB, free: 2.863 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003679/0.3896, allocations: 1.454 MB / 0.6729 GB, free: 1.926 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002821/0.3924, allocations: 1.377 MB / 0.6743 GB, free: 1.145 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004288/0.3967, allocations: 3.707 MB / 0.6779 GB, free: 15.29 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008918/0.3976, allocations: 0.4975 MB / 0.6784 GB, free: 14.99 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001959/0.3996, allocations: 1.37 MB / 0.6797 GB, free: 14.29 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001805/0.4014, allocations: 1.431 MB / 0.6811 GB, free: 13.63 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003957/0.4018, allocations: 312.9 kB / 0.6814 GB, free: 13.63 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008293/0.4026, allocations: 493.6 kB / 0.6819 GB, free: 13.58 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006556/0.4033, allocations: 0.7118 MB / 0.6826 GB, free: 13.09 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001198/0.4045, allocations: 1.122 MB / 0.6837 GB, free: 12.37 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004617/0.4091, allocations: 3.971 MB / 0.6876 GB, free: 10.61 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.799e-06/0.4091, allocations: 0 / 0.6876 GB, free: 10.61 MB / 478.1 MB
Notification: Performance of FrontEnd: time 1.694e-06/0.4091, allocations: 0 / 0.6876 GB, free: 10.61 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 7.834e-05/0.4092, allocations: 11.88 kB / 0.6876 GB, free: 10.6 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 377
 * Number of variables: 377
Notification: Performance of Generate backend data structure: time 0.01662/0.4258, allocations: 4.756 MB / 0.6922 GB, free: 7.758 MB / 478.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.224e-05/0.4258, allocations: 9.625 kB / 0.6922 GB, free: 7.758 MB / 478.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0004981/0.4263, allocations: 226.4 kB / 0.6925 GB, free: 7.574 MB / 478.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004901/0.4312, allocations: 0.8626 MB / 0.6933 GB, free: 7.195 MB / 478.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004048/0.4353, allocations: 1.702 MB / 0.695 GB, free: 5.895 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007508/0.436, allocations: 0.7285 MB / 0.6957 GB, free: 5.145 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004206/0.4364, allocations: 175.5 kB / 0.6958 GB, free: 5.082 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005316/0.4418, allocations: 2.275 MB / 0.6981 GB, free: 3.59 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.813e-05/0.4418, allocations: 10.64 kB / 0.6981 GB, free: 3.586 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002515/0.4421, allocations: 56.62 kB / 0.6981 GB, free: 3.543 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.221e-05/0.4421, allocations: 36.31 kB / 0.6982 GB, free: 3.543 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005189/0.4473, allocations: 1.927 MB / 0.7 GB, free: 2.598 MB / 478.1 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.0158/0.4631, allocations: 6.541 MB / 0.7064 GB, free: 13.8 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.009693/0.4728, allocations: 2.901 MB / 0.7093 GB, free: 12.47 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002567/0.4754, allocations: 1.062 MB / 0.7103 GB, free: 11.93 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001747/0.4755, allocations: 28.8 kB / 0.7103 GB, free: 11.92 MB / 494.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.309e-05/0.4756, allocations: 55.44 kB / 0.7104 GB, free: 11.86 MB / 494.1 MB
Notification: Performance of pre-optimization done (n=163): time 4.228e-06/0.4756, allocations: 0 / 0.7104 GB, free: 11.86 MB / 494.1 MB
Notification: Performance of matching and sorting (n=163): time 0.04657/0.5222, allocations: 10.99 MB / 0.7211 GB, free: 2.145 MB / 494.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001919/0.5224, allocations: 278.3 kB / 0.7214 GB, free: 1.812 MB / 494.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005305/0.5277, allocations: 2.171 MB / 0.7235 GB, free: 15.62 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004971/0.5282, allocations: 61.7 kB / 0.7235 GB, free: 15.55 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001124/0.5293, allocations: 0.9641 MB / 0.7245 GB, free: 14.57 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001126/0.5304, allocations: 0.6197 MB / 0.7251 GB, free: 13.95 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001855/0.5323, allocations: 493.2 kB / 0.7256 GB, free: 13.46 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001287/0.5324, allocations: 301.1 kB / 0.7259 GB, free: 13.16 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00337/0.5358, allocations: 1.297 MB / 0.7271 GB, free: 11.86 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003803/0.5396, allocations: 1.809 MB / 0.7289 GB, free: 9.898 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006422/0.546, allocations: 2.782 MB / 0.7316 GB, free: 7 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.327e-05/0.546, allocations: 4 kB / 0.7316 GB, free: 6.996 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=329) (initialization): time 0.01212/0.5581, allocations: 4.428 MB / 0.7359 GB, free: 2.516 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 2.683e-05/0.5582, allocations: 8 kB / 0.7359 GB, free: 2.508 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.909e-05/0.5582, allocations: 4.875 kB / 0.7359 GB, free: 2.504 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009649/0.5678, allocations: 2.696 MB / 0.7386 GB, free: 15.8 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002413/0.5702, allocations: 491.3 kB / 0.739 GB, free: 15.32 MB / 0.5137 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:268:5-268:157:writable] Error: Derivative of expression \"$res_NLSJac1_1 := min(gGOV1.min_select.u) - gGOV1.V.u\" w.r.t. \"dummyVarNLSJac1\" is non-existent.
Error: Internal error SymbolicJacobian.deriveAll failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2481:7-2481:74:writable] Error: Internal error SymbolicJacobian.generateSymbolicJacobian failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2272:9-2272:79:writable] Error: Internal error function createJacobian failed
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00767/0.5779, allocations: 3.427 MB / 0.7424 GB, free: 11.83 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0034/0.5813, allocations: 366 kB / 0.7427 GB, free: 11.47 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004184/0.5817, allocations: 91.92 kB / 0.7428 GB, free: 11.38 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004011/0.5857, allocations: 1.551 MB / 0.7443 GB, free: 9.82 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003432/0.5892, allocations: 1.736 MB / 0.746 GB, free: 7.934 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005867/0.595, allocations: 2.657 MB / 0.7486 GB, free: 5.164 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.082e-05/0.595, allocations: 7.938 kB / 0.7486 GB, free: 5.156 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=329) (initialization_lambda0): time 0.01084/0.6059, allocations: 4.269 MB / 0.7528 GB, free: 0.8398 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 1.904e-05/0.6059, allocations: 4 kB / 0.7528 GB, free: 0.8359 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.501e-05/0.6059, allocations: 11.98 kB / 0.7528 GB, free: 0.8242 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009295/0.6152, allocations: 2.674 MB / 0.7554 GB, free: 14.14 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002251/0.6175, allocations: 467.3 kB / 0.7559 GB, free: 13.68 MB / 0.5294 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:268:5-268:157:writable] Error: Derivative of expression \"$res_NLSJac3_1 := min(gGOV1.min_select.u) - gGOV1.V.u\" w.r.t. \"dummyVarNLSJac3\" is non-existent.
Error: Internal error SymbolicJacobian.deriveAll failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2481:7-2481:74:writable] Error: Internal error SymbolicJacobian.generateSymbolicJacobian failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2272:9-2272:79:writable] Error: Internal error function createJacobian failed
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007045/0.6245, allocations: 3.367 MB / 0.7592 GB, free: 10.25 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003189/0.6277, allocations: 302.6 kB / 0.7595 GB, free: 9.949 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002648/0.628, allocations: 91.97 kB / 0.7595 GB, free: 9.859 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 29
 * Number of states: 0 ()
 * Number of discrete variables: 4 (gGOV1.gGOV1_Power.s7.local_reset,gGOV1.gGOV1_Power.s2.local_reset,gGOV1.gGOV1_Turb.s3.local_reset,gGOV1.gGOV1_Temp.s6.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (272):
 * Single equations (assignments): 270
 * 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,2), (30,26)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005837/0.6285, allocations: 303.6 kB / 0.7598 GB, free: 9.555 MB / 0.5294 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006228/0.6292, allocations: 250.4 kB / 0.7601 GB, free: 9.309 MB / 0.5294 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01799/0.6472, allocations: 5.407 MB / 0.7654 GB, free: 3.883 MB / 0.5294 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.59e-05/0.6472, allocations: 16 kB / 0.7654 GB, free: 3.867 MB / 0.5294 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.808e-06/0.6472, allocations: 0 / 0.7654 GB, free: 3.867 MB / 0.5294 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.649e-05/0.6472, allocations: 11.97 kB / 0.7654 GB, free: 3.855 MB / 0.5294 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02208/0.6693, allocations: 7.199 MB / 0.7724 GB, free: 12.58 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.997e-05/0.6693, allocations: 4 kB / 0.7724 GB, free: 12.58 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00156/0.6709, allocations: 235.7 kB / 0.7726 GB, free: 12.35 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007906/0.6788, allocations: 2.195 MB / 0.7748 GB, free: 10.14 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000359/0.6792, allocations: 39.98 kB / 0.7748 GB, free: 10.11 MB / 0.545 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:268:5-268:157:writable] Error: Derivative of expression \"gGOV1.V.u = min(gGOV1.min_select.u)\" w.r.t. \"dummyVarNLSJac4\" is non-existent.
Error: Internal error SymbolicJacobian.deriveAll failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2481:7-2481:74:writable] Error: Internal error SymbolicJacobian.generateSymbolicJacobian failed
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2272:9-2272:79:writable] Error: Internal error function createJacobian failed
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02695/0.7061, allocations: 10.47 MB / 0.785 GB, free: 15.46 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.615e-06/0.7061, allocations: 4 kB / 0.785 GB, free: 15.46 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02154/0.7277, allocations: 6.954 MB / 0.7918 GB, free: 8.469 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001028/0.7287, allocations: 294.1 kB / 0.7921 GB, free: 8.18 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005501/0.7292, allocations: 39.98 kB / 0.7922 GB, free: 8.141 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00213/0.7314, allocations: 179.8 kB / 0.7923 GB, free: 7.965 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008189/0.7322, allocations: 300.8 kB / 0.7926 GB, free: 7.676 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001241/0.7323, allocations: 43.98 kB / 0.7927 GB, free: 7.633 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.002456/0.7348, allocations: 1.444 MB / 0.7941 GB, free: 6.176 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 1.3e-07/0.7348, allocations: 0 / 0.7941 GB, free: 6.176 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.002822/0.7376, allocations: 1.135 MB / 0.7952 GB, free: 5.039 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 19 (gENCLS.delta,gENCLS.eq,gENROU.w,gENROU.delta,gENROU.Epd,gENROU.Epq,gENROU.PSIkd,gENROU.PSIkq,gGOV1.gGOV1_Temp.s6.y,gGOV1.gGOV1_Turb.s4.TF.x_scaled[1],gGOV1.gGOV1_Turb.s3.y,gGOV1.gGOV1_Turb.s5.state,gGOV1.gGOV1_Turb.s9.TF.x_scaled[1],gGOV1.gGOV1_Accel.s8.x,gGOV1.gGOV1_Power.s2.y,gGOV1.gGOV1_Power.s7.y,gGOV1.gGOV1_Power.s0.state,gGOV1.gGOV1_Power.s1.x,gENCLS.omega)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (118):
 * Single equations (assignments): 116
 * 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
   {(26,23), (1,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02136/0.759, allocations: 7.573 MB / 0.8026 GB, free: 13.43 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.0177/0.7767, allocations: 5.539 MB / 0.808 GB, free: 7.887 MB / 0.5762 GB
Notification: Performance of simCode: created event and clocks part: time 5.65e-06/0.7767, allocations: 0 / 0.808 GB, free: 7.887 MB / 0.5762 GB
Notification: Performance of simCode: created simulation system equations: time 0.006861/0.7835, allocations: 2.114 MB / 0.81 GB, free: 5.766 MB / 0.5762 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002071/0.7856, allocations: 291 kB / 0.8103 GB, free: 5.492 MB / 0.5762 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06713/0.8527, allocations: 27.63 MB / 0.8373 GB, free: 9.449 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001052/0.8538, allocations: 0.9576 MB / 0.8382 GB, free: 8.453 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.001447/0.8552, allocations: 282.8 kB / 0.8385 GB, free: 8.172 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001398/0.8566, allocations: 0.9523 MB / 0.8394 GB, free: 7.219 MB / 0.6075 GB
Notification: Performance of SimCode: time 1.092e-06/0.8566, allocations: 0 / 0.8394 GB, free: 7.219 MB / 0.6075 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1207/0.9773, allocations: 68.4 MB / 0.9062 GB, free: 2.805 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 15.21/16.19, allocations: 11.41 kB / 0.9062 GB, free: 2.801 MB / 0.67 GB
"
[Timeout remaining time 644]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.sim & python3 -m fmpy simulate  --output-file OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1_res.csv --start-time 0 --stop-time 10 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.004 OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_TG_GGOV1.fmu > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 19.551908415276557]
Failed to read output from testmodel.py, exit status != 0:
16.347415328025818 16.362522893 15.950308142
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc1ba2f2fb0>