Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo", uses=false) 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 3.2.3+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 2.0.0/package.mo", uses=false) 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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.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-master/package.mo) Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A") translateModel(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo): time 0.1204/0.1204, allocations: 12.6 MB / 28.91 MB, free: 0.6367 MB / 19.63 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001246/0.001245, allocations: 107.5 kB / 32.51 MB, free: 3.574 MB / 26.18 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.478/1.478, allocations: 205.1 MB / 241.1 MB, free: 12.36 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001591/0.001591, allocations: 188.5 kB / 291.4 MB, free: 13.38 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.4373/0.4373, allocations: 78.5 MB / 420 MB, free: 11.26 MB / 302.1 MB Notification: Modelica_Synchronous requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.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.0.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.0.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.0.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.002707/0.002708, allocations: 140 kB / 0.5565 GB, free: 28.39 MB / 398.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1477/0.1504, allocations: 68.13 MB / 0.6231 GB, free: 15.4 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A): time 0.01401/0.1645, allocations: 10.62 MB / 0.6335 GB, free: 4.719 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.01103/0.1755, allocations: 3.762 MB / 0.6371 GB, free: 0.9492 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.003627/0.1793, allocations: 27.94 kB / 0.6372 GB, free: 0.9219 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.002344/0.1816, allocations: 0.5309 MB / 0.6377 GB, free: 396 kB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.00639/0.1881, allocations: 1.613 MB / 0.6392 GB, free: 14.77 MB / 462.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.004523/0.1926, allocations: 1.384 MB / 0.6406 GB, free: 13.39 MB / 462.1 MB Notification: Performance of NFFlatten.flatten: time 0.007851/0.2005, allocations: 4.78 MB / 0.6453 GB, free: 8.605 MB / 462.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001902/0.2024, allocations: 0.7581 MB / 0.646 GB, free: 7.805 MB / 462.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.003627/0.206, allocations: 1.748 MB / 0.6477 GB, free: 6.051 MB / 462.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.003858/0.2099, allocations: 1.969 MB / 0.6496 GB, free: 4.074 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001662/0.2116, allocations: 352 kB / 0.65 GB, free: 3.73 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002184/0.2138, allocations: 0.5233 MB / 0.6505 GB, free: 3.207 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.001784/0.2156, allocations: 0.8876 MB / 0.6513 GB, free: 2.316 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.003332/0.219, allocations: 1.538 MB / 0.6529 GB, free: 0.7695 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.008161/0.2272, allocations: 4.183 MB / 0.6569 GB, free: 12.57 MB / 478.1 MB Notification: Performance of FrontEnd - DAE generated: time 6.853e-06/0.2272, allocations: 0 / 0.6569 GB, free: 12.57 MB / 478.1 MB Notification: Performance of FrontEnd: time 1.873e-06/0.2272, allocations: 0 / 0.6569 GB, free: 12.57 MB / 478.1 MB Notification: Performance of Transformations before backend: time 0.0001793/0.2274, allocations: 0 / 0.6569 GB, free: 12.57 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: 385 * Number of variables: 385 Notification: Performance of Generate backend data structure: time 0.02577/0.2532, allocations: 6.025 MB / 0.6628 GB, free: 6.473 MB / 478.1 MB Notification: Performance of prepare preOptimizeDAE: time 7.022e-05/0.2533, allocations: 15.92 kB / 0.6628 GB, free: 6.457 MB / 478.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006104/0.2594, allocations: 0.8996 MB / 0.6637 GB, free: 5.555 MB / 478.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.007855/0.2673, allocations: 2.482 MB / 0.6661 GB, free: 3.008 MB / 478.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009834/0.2683, allocations: 0.7257 MB / 0.6668 GB, free: 2.148 MB / 478.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009284/0.2692, allocations: 175.9 kB / 0.667 GB, free: 1.977 MB / 478.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.007451/0.2767, allocations: 2.305 MB / 0.6693 GB, free: 15.62 MB / 494.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 5.389e-05/0.2768, allocations: 4 kB / 0.6693 GB, free: 15.62 MB / 494.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005123/0.2773, allocations: 60 kB / 0.6693 GB, free: 15.56 MB / 494.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.22e-05/0.2774, allocations: 36 kB / 0.6694 GB, free: 15.53 MB / 494.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006517/0.2839, allocations: 2.44 MB / 0.6717 GB, free: 13.08 MB / 494.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.02017/0.3041, allocations: 7.823 MB / 0.6794 GB, free: 5.059 MB / 494.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0126/0.3167, allocations: 4.548 MB / 0.6838 GB, free: 388 kB / 494.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.003395/0.3202, allocations: 1.402 MB / 0.6852 GB, free: 14.97 MB / 0.4981 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0002531/0.3205, allocations: 33.98 kB / 0.6852 GB, free: 14.93 MB / 0.4981 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004086/0.3246, allocations: 1.669 MB / 0.6869 GB, free: 13.24 MB / 0.4981 GB Notification: Performance of pre-optimization done (n=193): time 7.914e-06/0.3246, allocations: 0 / 0.6869 GB, free: 13.24 MB / 0.4981 GB Notification: Performance of matching and sorting (n=193): time 0.04911/0.3737, allocations: 11.87 MB / 0.6984 GB, free: 1.309 MB / 0.4981 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002323/0.374, allocations: 206 kB / 0.6986 GB, free: 1.066 MB / 0.4981 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009005/0.383, allocations: 3.081 MB / 0.7016 GB, free: 13.96 MB / 0.5137 GB Notification: Performance of collectPreVariables (initialization): time 0.0007594/0.3838, allocations: 73.7 kB / 0.7017 GB, free: 13.89 MB / 0.5137 GB Notification: Performance of collectInitialEqns (initialization): time 0.001298/0.3851, allocations: 1.041 MB / 0.7027 GB, free: 12.84 MB / 0.5137 GB Notification: Performance of collectInitialBindings (initialization): time 0.001418/0.3866, allocations: 0.7243 MB / 0.7034 GB, free: 12.11 MB / 0.5137 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.002229/0.3888, allocations: 469.4 kB / 0.7039 GB, free: 11.64 MB / 0.5137 GB Notification: Performance of setup shared object (initialization): time 0.000165/0.389, allocations: 309.1 kB / 0.7042 GB, free: 11.34 MB / 0.5137 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003733/0.3927, allocations: 1.492 MB / 0.7056 GB, free: 9.836 MB / 0.5137 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.004101/0.3968, allocations: 1.75 MB / 0.7074 GB, free: 8.023 MB / 0.5137 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.4638/0.8606, allocations: 9.138 MB / 0.7163 GB, free: 80.06 MB / 0.5137 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.252e-05/0.8607, allocations: 1.25 kB / 0.7163 GB, free: 80.06 MB / 0.5137 GB Notification: Performance of matching and sorting (n=332) (initialization): time 0.01164/0.8723, allocations: 4.487 MB / 0.7207 GB, free: 79.35 MB / 0.5137 GB Notification: Performance of prepare postOptimizeDAE: time 3.032e-05/0.8724, allocations: 10.17 kB / 0.7207 GB, free: 79.35 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.044e-05/0.8724, allocations: 5.969 kB / 0.7207 GB, free: 79.35 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.00974/0.8822, allocations: 2.417 MB / 0.723 GB, free: 79.02 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005176/0.8874, allocations: 0.8451 MB / 0.7239 GB, free: 78.98 MB / 0.5137 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01223/0.8996, allocations: 9.948 MB / 0.7336 GB, free: 70.59 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006015/0.9057, allocations: 0.552 MB / 0.7341 GB, free: 70.54 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006679/0.9063, allocations: 86.08 kB / 0.7342 GB, free: 70.52 MB / 0.5137 GB Warning: Assuming fixed start value for the following 6 variables: gENROE.Epd:VARIABLE(start = gENROE.Epd0 unit = "1" fixed = true ) "d-axis voltage behind transient reactance" type: Real pSS2A.rampTrackingFilter.TF2[1].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [1,1] pSS2A.rampTrackingFilter.TF1[5].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[4].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[3].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[2].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.005421/0.9118, allocations: 1.906 MB / 0.7361 GB, free: 69.7 MB / 0.5137 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.004003/0.9158, allocations: 1.705 MB / 0.7377 GB, free: 68.95 MB / 0.5137 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03245/0.9483, allocations: 9.004 MB / 0.7465 GB, free: 66.26 MB / 0.5137 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.108e-05/0.9483, allocations: 0 / 0.7465 GB, free: 66.26 MB / 0.5137 GB Notification: Performance of matching and sorting (n=332) (initialization_lambda0): time 0.009866/0.9582, allocations: 4.402 MB / 0.7508 GB, free: 64.64 MB / 0.5137 GB Notification: Performance of prepare postOptimizeDAE: time 2.799e-05/0.9583, allocations: 3.906 kB / 0.7508 GB, free: 64.64 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.726e-05/0.9583, allocations: 3.969 kB / 0.7508 GB, free: 64.64 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.007903/0.9662, allocations: 2.423 MB / 0.7532 GB, free: 63.8 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003895/0.9702, allocations: 0.6543 MB / 0.7538 GB, free: 63.51 MB / 0.5137 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007443/0.9776, allocations: 6.836 MB / 0.7605 GB, free: 56.25 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004464/0.9821, allocations: 0.5036 MB / 0.761 GB, free: 55.79 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003277/0.9825, allocations: 87.97 kB / 0.7611 GB, free: 55.7 MB / 0.5137 GB Warning: Assuming fixed start value for the following 6 variables: gENROE.Epd:VARIABLE(start = gENROE.Epd0 unit = "1" fixed = true ) "d-axis voltage behind transient reactance" type: Real pSS2A.rampTrackingFilter.TF2[1].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [1,1] pSS2A.rampTrackingFilter.TF1[5].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[4].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[3].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] pSS2A.rampTrackingFilter.TF1[2].x_scaled[1]:VARIABLE(fixed = true protected = true ) "Scaled vector x" type: Real [5,1] Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 15 * 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 (279): * Single equations (assignments): 273 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 4 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 4 systems {1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(27,26)} Notification: Performance of prepare postOptimizeDAE: time 0.0009111/0.9834, allocations: 321.4 kB / 0.7614 GB, free: 55.39 MB / 0.5137 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006632/0.9841, allocations: 294 kB / 0.7617 GB, free: 55.1 MB / 0.5137 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01723/1.001, allocations: 6.227 MB / 0.7677 GB, free: 48.85 MB / 0.5137 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.42e-05/1.001, allocations: 11.95 kB / 0.7678 GB, free: 48.84 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.231e-06/1.001, allocations: 11.94 kB / 0.7678 GB, free: 48.82 MB / 0.5137 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001174/1.003, allocations: 459.1 kB / 0.7682 GB, free: 48.38 MB / 0.5137 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005713/1.003, allocations: 43.98 kB / 0.7682 GB, free: 48.34 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002747/1.006, allocations: 395.4 kB / 0.7686 GB, free: 47.95 MB / 0.5137 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001421/1.007, allocations: 0.6025 MB / 0.7692 GB, free: 47.35 MB / 0.5137 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0106/1.018, allocations: 4.437 MB / 0.7735 GB, free: 42.95 MB / 0.5137 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.008274/1.026, allocations: 4.996 MB / 0.7784 GB, free: 37.93 MB / 0.5137 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002307/1.029, allocations: 1.344 MB / 0.7797 GB, free: 36.58 MB / 0.5137 GB Notification: Performance of sorting global known variables: time 0.004958/1.034, allocations: 2.229 MB / 0.7819 GB, free: 34.35 MB / 0.5137 GB Notification: Performance of Backend: time 3.91e-07/1.034, allocations: 0 / 0.7819 GB, free: 34.35 MB / 0.5137 GB Notification: Performance of simCode: created initialization part: time 0.01773/1.051, allocations: 6.055 MB / 0.7878 GB, free: 28.29 MB / 0.5137 GB Notification: Performance of SimCode: time 0.007873/1.059, allocations: 6.026 MB / 0.7937 GB, free: 22.27 MB / 0.5137 GB Notification: Performance of Templates: time 0.09849/1.158, allocations: 59.3 MB / 0.8516 GB, free: 11 MB / 0.5606 GB make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.makefile (rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.sim & ./OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.PSS.PSS2A.pipe 2>&1)