Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo", uses=false) Using package OpenIPSL with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1") translateModel(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001151/0.001151, allocations: 109.5 kB / 16.41 MB, free: 6.461 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.381/1.381, allocations: 222.9 MB / 240.1 MB, free: 4.52 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001498/0.001498, allocations: 188.5 kB / 290.4 MB, free: 2.25 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.4777/0.4777, allocations: 78.55 MB / 419.1 MB, free: 3.168 MB / 286.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001534/0.001534, allocations: 79.88 kB / 0.5543 GB, free: 1.008 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2901/0.2916, allocations: 68.17 MB / 0.6209 GB, free: 9.684 MB / 430.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.TG.GGOV1): time 0.008397/0.3001, allocations: 11.19 MB / 0.6318 GB, free: 15.04 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.007731/0.3078, allocations: 4.056 MB / 0.6358 GB, free: 10.98 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001969/0.3098, allocations: 31.88 kB / 0.6358 GB, free: 10.95 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.001367/0.3112, allocations: 459.9 kB / 0.6362 GB, free: 10.49 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0041/0.3154, allocations: 1.474 MB / 0.6377 GB, free: 9.016 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.002681/0.3181, allocations: 1.364 MB / 0.639 GB, free: 7.66 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.004391/0.3225, allocations: 3.638 MB / 0.6426 GB, free: 4.012 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001272/0.3238, allocations: 0.7697 MB / 0.6433 GB, free: 3.211 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.001827/0.3256, allocations: 1.319 MB / 0.6446 GB, free: 1.887 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002077/0.3277, allocations: 1.563 MB / 0.6461 GB, free: 324 kB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0006029/0.3283, allocations: 312 kB / 0.6464 GB, free: 12 kB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001009/0.3293, allocations: 0.5349 MB / 0.6469 GB, free: 15.48 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0005734/0.3299, allocations: 0.7006 MB / 0.6476 GB, free: 14.77 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.001258/0.3312, allocations: 1.399 MB / 0.649 GB, free: 13.37 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.003888/0.3351, allocations: 3.939 MB / 0.6528 GB, free: 9.418 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 4.077e-06/0.3351, allocations: 0 / 0.6528 GB, free: 9.418 MB / 462.1 MB Notification: Performance of FrontEnd: time 1.362e-06/0.3351, allocations: 3.938 kB / 0.6528 GB, free: 9.414 MB / 462.1 MB Notification: Performance of Transformations before backend: time 6.016e-05/0.3352, allocations: 0 / 0.6528 GB, free: 9.414 MB / 462.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.01593/0.3511, allocations: 4.824 MB / 0.6576 GB, free: 4.52 MB / 462.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.438e-05/0.3512, allocations: 8.031 kB / 0.6576 GB, free: 4.512 MB / 462.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005253/0.3564, allocations: 0.8686 MB / 0.6584 GB, free: 3.641 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003515/0.36, allocations: 1.751 MB / 0.6601 GB, free: 1.82 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005652/0.3605, allocations: 0.5249 MB / 0.6606 GB, free: 1.215 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004616/0.361, allocations: 172 kB / 0.6608 GB, free: 1.047 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.004552/0.3656, allocations: 2.123 MB / 0.6629 GB, free: 14.84 MB / 478.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 3.574e-05/0.3656, allocations: 11.94 kB / 0.6629 GB, free: 14.83 MB / 478.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000176/0.3658, allocations: 60 kB / 0.6629 GB, free: 14.77 MB / 478.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.911e-05/0.3659, allocations: 40 kB / 0.663 GB, free: 14.73 MB / 478.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004559/0.3704, allocations: 1.936 MB / 0.6649 GB, free: 12.79 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.01475/0.3852, allocations: 7.923 MB / 0.6726 GB, free: 4.613 MB / 478.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.009935/0.3951, allocations: 3.491 MB / 0.676 GB, free: 0.9922 MB / 478.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.00279/0.398, allocations: 1.174 MB / 0.6772 GB, free: 15.81 MB / 494.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0002319/0.3982, allocations: 29.28 kB / 0.6772 GB, free: 15.78 MB / 494.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.576e-05/0.3983, allocations: 55.81 kB / 0.6772 GB, free: 15.72 MB / 494.1 MB Notification: Performance of pre-optimization done (n=163): time 4.469e-06/0.3983, allocations: 0 / 0.6772 GB, free: 15.72 MB / 494.1 MB Notification: Performance of matching and sorting (n=163): time 0.04558/0.4439, allocations: 11.19 MB / 0.6882 GB, free: 4.465 MB / 494.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001324/0.4441, allocations: 278.3 kB / 0.6884 GB, free: 4.129 MB / 494.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003823/0.4479, allocations: 2.147 MB / 0.6905 GB, free: 1.957 MB / 494.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0003723/0.4483, allocations: 61.7 kB / 0.6906 GB, free: 1.891 MB / 494.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0008422/0.4491, allocations: 0.9602 MB / 0.6915 GB, free: 0.918 MB / 494.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.000784/0.4499, allocations: 0.6158 MB / 0.6921 GB, free: 304 kB / 494.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001126/0.4511, allocations: 485.3 kB / 0.6926 GB, free: 15.81 MB / 0.4981 GB Notification: Performance of setup shared object (initialization): time 0.0001011/0.4512, allocations: 301.1 kB / 0.6929 GB, free: 15.52 MB / 0.4981 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.002986/0.4542, allocations: 1.297 MB / 0.6942 GB, free: 14.21 MB / 0.4981 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00336/0.4575, allocations: 1.674 MB / 0.6958 GB, free: 12.42 MB / 0.4981 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.005967/0.4635, allocations: 2.786 MB / 0.6985 GB, free: 9.52 MB / 0.4981 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.578e-06/0.4635, allocations: 0 / 0.6985 GB, free: 9.52 MB / 0.4981 GB Notification: Performance of matching and sorting (n=329) (initialization): time 0.01112/0.4747, allocations: 4.463 MB / 0.7029 GB, free: 5.004 MB / 0.4981 GB Notification: Performance of prepare postOptimizeDAE: time 2.541e-05/0.4747, allocations: 11.98 kB / 0.7029 GB, free: 4.992 MB / 0.4981 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.66e-05/0.4747, allocations: 8 kB / 0.7029 GB, free: 4.984 MB / 0.4981 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.009323/0.4841, allocations: 2.707 MB / 0.7055 GB, free: 2.273 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002346/0.4864, allocations: 495.3 kB / 0.706 GB, free: 1.789 MB / 0.4981 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:2474:7-2474:87:writable] Error: Internal error function generateSymbolicJacobian failed [/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2265:9-2265:79:writable] Error: Internal error function createJacobian failed Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007076/0.4935, allocations: 3.421 MB / 0.7093 GB, free: 14.29 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00304/0.4966, allocations: 366.1 kB / 0.7097 GB, free: 13.93 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003324/0.4969, allocations: 91.97 kB / 0.7098 GB, free: 13.84 MB / 0.5137 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00358/0.5005, allocations: 1.548 MB / 0.7113 GB, free: 12.29 MB / 0.5137 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003052/0.5036, allocations: 1.588 MB / 0.7128 GB, free: 10.59 MB / 0.5137 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005479/0.5091, allocations: 2.654 MB / 0.7154 GB, free: 7.816 MB / 0.5137 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.049e-05/0.5091, allocations: 7.938 kB / 0.7154 GB, free: 7.809 MB / 0.5137 GB Notification: Performance of matching and sorting (n=329) (initialization_lambda0): time 0.0104/0.5195, allocations: 4.314 MB / 0.7197 GB, free: 3.441 MB / 0.5137 GB Notification: Performance of prepare postOptimizeDAE: time 1.914e-05/0.5195, allocations: 8 kB / 0.7197 GB, free: 3.434 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.316e-05/0.5196, allocations: 8 kB / 0.7197 GB, free: 3.426 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.008987/0.5286, allocations: 2.684 MB / 0.7223 GB, free: 0.7383 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002065/0.5306, allocations: 475.3 kB / 0.7227 GB, free: 280 kB / 0.5137 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:2474:7-2474:87:writable] Error: Internal error function generateSymbolicJacobian failed [/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2265:9-2265:79:writable] Error: Internal error function createJacobian failed Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006724/0.5374, allocations: 3.358 MB / 0.726 GB, free: 12.84 MB / 0.5294 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002868/0.5403, allocations: 314.6 kB / 0.7263 GB, free: 12.54 MB / 0.5294 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000283/0.5406, allocations: 95.98 kB / 0.7264 GB, free: 12.44 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.0005915/0.5412, allocations: 303.8 kB / 0.7267 GB, free: 12.14 MB / 0.5294 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000614/0.5418, allocations: 250.4 kB / 0.7269 GB, free: 11.89 MB / 0.5294 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01781/0.5596, allocations: 5.442 MB / 0.7323 GB, free: 6.422 MB / 0.5294 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.105e-05/0.5597, allocations: 7.969 kB / 0.7323 GB, free: 6.414 MB / 0.5294 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.144e-06/0.5597, allocations: 3.984 kB / 0.7323 GB, free: 6.41 MB / 0.5294 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0008006/0.5605, allocations: 371 kB / 0.7326 GB, free: 6.027 MB / 0.5294 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006216/0.5611, allocations: 39.94 kB / 0.7327 GB, free: 5.988 MB / 0.5294 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002352/0.5635, allocations: 179.8 kB / 0.7328 GB, free: 5.812 MB / 0.5294 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00157/0.5651, allocations: 0.5785 MB / 0.7334 GB, free: 5.234 MB / 0.5294 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01063/0.5757, allocations: 3.48 MB / 0.7368 GB, free: 1.742 MB / 0.5294 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.008414/0.5842, allocations: 3.882 MB / 0.7406 GB, free: 13.83 MB / 0.545 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002352/0.5865, allocations: 1.033 MB / 0.7416 GB, free: 12.8 MB / 0.545 GB Notification: Performance of sorting global known variables: time 0.002688/0.5892, allocations: 1.432 MB / 0.743 GB, free: 11.35 MB / 0.545 GB Notification: Performance of Backend: time 6.82e-07/0.5893, allocations: 0 / 0.743 GB, free: 11.35 MB / 0.545 GB Notification: Performance of simCode: created initialization part: time 0.01711/0.6064, allocations: 5.133 MB / 0.748 GB, free: 6.215 MB / 0.545 GB Notification: Performance of SimCode: time 0.00742/0.6138, allocations: 5.074 MB / 0.753 GB, free: 1.086 MB / 0.545 GB Notification: Performance of Templates: time 0.311/0.9248, allocations: 50.89 MB / 0.8027 GB, free: 114.6 MB / 0.5606 GB make -j1 -f OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.makefile (rm -f OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe ; mkfifo OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe >> ../files/OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.sim & ./OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1 -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_OpenIPSL.Tests.Controls.PSSE.TG.GGOV1.pipe 2>&1)