Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001349/0.001349, allocations: 100.2 kB / 20.44 MB, free: 4.133 MB / 18.57 MB
"
[Timeout remaining time 180]
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.001463/0.001463, allocations: 165 kB / 23.81 MB, free: 0.7656 MB / 18.57 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 0.7964/0.7964, allocations: 158.6 MB / 185.7 MB, free: 2.922 MB / 170.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.05278/0.05278, allocations: 10.65 MB / 248.7 MB, free: 4.465 MB / 234.7 MB
"
[Timeout remaining time 180]
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/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 Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter=".*",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation")
translateModel(PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter=".*",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.044e-06/2.044e-06, allocations: 0 / 317.9 MB, free: 41.89 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.454e-05/2.658e-05, allocations: 2.969 kB / 317.9 MB, free: 41.88 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation): time 0.06067/0.06069, allocations: 109.7 MB / 427.6 MB, free: 11.85 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.2238/0.2845, allocations: 40.08 MB / 467.7 MB, free: 9.406 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02126/0.3058, allocations: 407.9 kB / 468.1 MB, free: 9.406 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.01822/0.324, allocations: 5.674 MB / 473.7 MB, free: 8.797 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.04614/0.3701, allocations: 18.06 MB / 491.8 MB, free: 380 kB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01365/0.3838, allocations: 3.821 MB / 495.6 MB, free: 13.53 MB / 378.7 MB
Notification: Performance of NFFlatten.flatten: time 0.05311/0.4369, allocations: 42.61 MB / 0.5256 GB, free: 3.012 MB / 394.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006253/0.4431, allocations: 1.694 MB / 0.5273 GB, free: 2.051 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.04704/0.4902, allocations: 19.13 MB / 0.546 GB, free: 15.79 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.02548/0.5157, allocations: 11.96 MB / 0.5576 GB, free: 4.34 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.008791/0.5244, allocations: 1.844 MB / 0.5594 GB, free: 2.496 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0192/0.5436, allocations: 3.835 MB / 0.5632 GB, free: 14.67 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.008848/0.5525, allocations: 4.148 MB / 0.5672 GB, free: 10.76 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.02356/0.5761, allocations: 9.197 MB / 0.5762 GB, free: 1.801 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.04326/0.6193, allocations: 18.79 MB / 0.5946 GB, free: 460 kB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.045e-06/0.6193, allocations: 0 / 0.5946 GB, free: 460 kB / 458.7 MB
Notification: Performance of FrontEnd: time 1.883e-06/0.6193, allocations: 4 kB / 0.5946 GB, free: 456 kB / 458.7 MB
Notification: Performance of Transformations before backend: time 0.0009839/0.6203, allocations: 0 / 0.5946 GB, free: 456 kB / 458.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3837
 * Number of variables: 3837
Notification: Performance of Generate backend data structure: time 0.4042/1.024, allocations: 30.56 MB / 0.6244 GB, free: 76.78 MB / 458.8 MB
Notification: Performance of prepare preOptimizeDAE: time 4.807e-05/1.025, allocations: 7.312 kB / 0.6244 GB, free: 76.78 MB / 458.8 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02055/1.045, allocations: 4.568 MB / 0.6289 GB, free: 75.61 MB / 458.8 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02671/1.072, allocations: 10.28 MB / 0.6389 GB, free: 73.32 MB / 458.8 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001517/1.073, allocations: 1.341 MB / 0.6402 GB, free: 73.1 MB / 458.8 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005326/1.079, allocations: 1.519 MB / 0.6417 GB, free: 73.1 MB / 458.8 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03106/1.11, allocations: 12.21 MB / 0.6536 GB, free: 69.93 MB / 458.8 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003874/1.11, allocations: 23.34 kB / 0.6537 GB, free: 69.93 MB / 458.8 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001171/1.111, allocations: 0.6118 MB / 0.6543 GB, free: 69.93 MB / 458.8 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002583/1.112, allocations: 367 kB / 0.6546 GB, free: 69.93 MB / 458.8 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01512/1.127, allocations: 8.862 MB / 0.6633 GB, free: 64.71 MB / 458.8 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.11/1.237, allocations: 65.4 MB / 0.7271 GB, free: 15.14 MB / 474.8 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02728/1.264, allocations: 17.39 MB / 0.7441 GB, free: 14.23 MB / 490.8 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01103/1.275, allocations: 4.839 MB / 0.7488 GB, free: 9.309 MB / 490.8 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001005/1.276, allocations: 297 kB / 0.7491 GB, free: 9.016 MB / 490.8 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01182/1.288, allocations: 6.99 MB / 0.7559 GB, free: 1.676 MB / 490.8 MB
Notification: Performance of pre-optimization done (n=1720): time 2.166e-05/1.288, allocations: 0 / 0.7559 GB, free: 1.676 MB / 490.8 MB
Notification: Performance of matching and sorting (n=1720): time 0.03876/1.327, allocations: 17.37 MB / 0.7729 GB, free: 432 kB / 0.4949 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.2109/1.537, allocations: 1.599 MB / 0.7745 GB, free: 108.8 MB / 0.4949 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01622/1.554, allocations: 10.05 MB / 0.7843 GB, free: 108 MB / 0.4949 GB
Notification: Performance of collectPreVariables (initialization): time 0.003293/1.557, allocations: 347.7 kB / 0.7846 GB, free: 108 MB / 0.4949 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006986/1.564, allocations: 7.242 MB / 0.7917 GB, free: 107.3 MB / 0.4949 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00899/1.573, allocations: 6.194 MB / 0.7977 GB, free: 103.3 MB / 0.4949 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006585/1.58, allocations: 3.465 MB / 0.8011 GB, free: 103 MB / 0.4949 GB
Notification: Performance of setup shared object (initialization): time 5.477e-05/1.58, allocations: 477.8 kB / 0.8016 GB, free: 102.5 MB / 0.4949 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006245/1.586, allocations: 3.74 MB / 0.8052 GB, free: 102.1 MB / 0.4949 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008568/1.594, allocations: 9.131 MB / 0.8141 GB, free: 95.82 MB / 0.4949 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01862/1.613, allocations: 14.04 MB / 0.8279 GB, free: 89.32 MB / 0.4949 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001633/1.613, allocations: 28.16 kB / 0.8279 GB, free: 89.32 MB / 0.4949 GB
Notification: Performance of matching and sorting (n=2616) (initialization): time 0.05238/1.666, allocations: 18.88 MB / 0.8463 GB, free: 86.78 MB / 0.4949 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002069/1.666, allocations: 335.8 kB / 0.8466 GB, free: 86.5 MB / 0.4949 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001499/1.666, allocations: 105.8 kB / 0.8467 GB, free: 86.5 MB / 0.4949 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03723/1.703, allocations: 25.03 MB / 0.8712 GB, free: 67.03 MB / 0.4949 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01036/1.714, allocations: 3.698 MB / 0.8748 GB, free: 64.16 MB / 0.4949 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02822/1.742, allocations: 62.73 MB / 0.9361 GB, free: 1.672 MB / 0.4949 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01827/1.76, allocations: 1.914 MB / 0.9379 GB, free: 15.79 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004236/1.764, allocations: 0.7377 MB / 0.9387 GB, free: 15.06 MB / 0.5105 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01574/1.78, allocations: 4.101 MB / 0.9427 GB, free: 11.33 MB / 0.5105 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01383/1.794, allocations: 9.105 MB / 0.9515 GB, free: 204 kB / 0.5105 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.2321/2.026, allocations: 14.1 MB / 0.9653 GB, free: 93.2 MB / 0.5105 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001512/2.026, allocations: 30.62 kB / 0.9653 GB, free: 93.2 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=2616) (initialization_lambda0): time 0.04962/2.076, allocations: 20.16 MB / 0.985 GB, free: 91.58 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002579/2.076, allocations: 335.6 kB / 0.9854 GB, free: 91.3 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001998/2.076, allocations: 101.7 kB / 0.9855 GB, free: 91.3 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03893/2.115, allocations: 20.78 MB / 1.006 GB, free: 90.37 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01069/2.126, allocations: 3.852 MB / 1.01 GB, free: 87.92 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.06478/2.191, allocations: 91.18 MB / 1.099 GB, free: 9.48 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01582/2.206, allocations: 1.593 MB / 1.1 GB, free: 8.305 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003179/2.21, allocations: 0.7304 MB / 1.101 GB, free: 7.574 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 474
 * Number of states: 0 ()
 * Number of discrete variables: 80 (Tgen2.breakerStatusInInternal,L1to5.breakerStatusInternalB,L1to5.breakerStatusInternalA,$PRE.Tgen2.breakerStatusInInternal,$PRE.L1to5.breakerStatusInternalB,$PRE.L1to5.breakerStatusInternalA,GEN8.AVR.limiterWithLag.satON,$PRE.GEN8.AVR.limiterWithLag.satON,GEN8.AVR.limiterWithLag.saturationLimitReached,$PRE.GEN8.AVR.limiterWithLag.saturationLimitReached,GEN8.AVR.limiterWithLag.state,$PRE.GEN8.AVR.limiterWithLag.state,GEN6.AVR.limiterWithLag.satON,$PRE.GEN6.AVR.limiterWithLag.satON,GEN6.AVR.limiterWithLag.saturationLimitReached,$PRE.GEN6.AVR.limiterWithLag.saturationLimitReached,GEN6.AVR.limiterWithLag.state,$PRE.GEN6.AVR.limiterWithLag.state,GEN3.AVR.limiterWithLag.satON,$PRE.GEN3.AVR.limiterWithLag.satON,GEN3.AVR.limiterWithLag.saturationLimitReached,$PRE.GEN3.AVR.limiterWithLag.saturationLimitReached,GEN3.AVR.limiterWithLag.state,$PRE.GEN3.AVR.limiterWithLag.state,GEN2.AVR.limiterWithLag.satON,$PRE.GEN2.AVR.limiterWithLag.satON,GEN2.AVR.limiterWithLag.saturationLimitReached,$PRE.GEN2.AVR.limiterWithLag.saturationLimitReached,GEN2.AVR.limiterWithLag.state,$PRE.GEN2.AVR.limiterWithLag.state,GEN1.AVR.limiterWithLag.satON,$PRE.GEN1.AVR.limiterWithLag.satON,GEN1.AVR.limiterWithLag.saturationLimitReached,$PRE.GEN1.AVR.limiterWithLag.saturationLimitReached,GEN1.AVR.limiterWithLag.state,$PRE.GEN1.AVR.limiterWithLag.state,Tgen2.breakerStatus,$PRE.Tgen2.breakerStatus,L1to5.breakerStatus,$PRE.L1to5.breakerStatus,$whenCondition40,$whenCondition39,$whenCondition38,$whenCondition37,$whenCondition36,$whenCondition35,$whenCondition34,$whenCondition33,$whenCondition32,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2038):
 * Single equations (assignments): 2002
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 10
 * Torn equation systems: 22
 * 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): 10 systems
   {2, 2, 2, 2, 2, 2, 2, 2, 2, 2}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 10 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 12 systems
   {(42,434), (5,31), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.004468/2.214, allocations: 1.662 MB / 1.102 GB, free: 6.156 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006094/2.22, allocations: 2.236 MB / 1.105 GB, free: 3.91 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03016/2.25, allocations: 15.08 MB / 1.119 GB, free: 4.945 MB / 0.5262 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001153/2.25, allocations: 160 kB / 1.12 GB, free: 4.789 MB / 0.5262 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.877e-05/2.25, allocations: 0 / 1.12 GB, free: 4.789 MB / 0.5262 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004082/2.251, allocations: 87.62 kB / 1.12 GB, free: 4.703 MB / 0.5262 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.2968/2.548, allocations: 28.93 MB / 1.148 GB, free: 108.2 MB / 0.5418 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.378e-05/2.548, allocations: 1.312 kB / 1.148 GB, free: 108.2 MB / 0.5418 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007415/2.555, allocations: 2.281 MB / 1.15 GB, free: 108.2 MB / 0.5418 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02146/2.577, allocations: 8.893 MB / 1.159 GB, free: 107.9 MB / 0.5418 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002799/2.579, allocations: 315.9 kB / 1.159 GB, free: 107.9 MB / 0.5418 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.05038/2.63, allocations: 26.97 MB / 1.185 GB, free: 105.5 MB / 0.5418 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.548e-06/2.63, allocations: 2.469 kB / 1.185 GB, free: 105.5 MB / 0.5418 GB
Notification: Tearing is skipped for strong component 68 because system size of 490 exceeds maximum system size for tearing of linear systems (200).
To adjust the maximum system size for tearing use --maxSizeLinearTearing=<size>.
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1709/2.801, allocations: 84.04 MB / 1.267 GB, free: 55.9 MB / 0.5418 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0112/2.812, allocations: 3.952 MB / 1.271 GB, free: 51.92 MB / 0.5418 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004647/2.816, allocations: 307.9 kB / 1.272 GB, free: 51.62 MB / 0.5418 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01189/2.828, allocations: 427.8 kB / 1.272 GB, free: 51.2 MB / 0.5418 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003664/2.832, allocations: 1.208 MB / 1.273 GB, free: 49.99 MB / 0.5418 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001022/2.833, allocations: 417 kB / 1.274 GB, free: 49.59 MB / 0.5418 GB
Notification: Performance of sorting global known variables: time 0.008137/2.841, allocations: 5.704 MB / 1.279 GB, free: 43.95 MB / 0.5418 GB
Notification: Performance of sort global known variables: time 2e-07/2.841, allocations: 0 / 1.279 GB, free: 43.95 MB / 0.5418 GB
Notification: Performance of remove unused functions: time 0.05978/2.901, allocations: 16.51 MB / 1.295 GB, free: 27.43 MB / 0.5418 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 30 (GEN1.GEN.theta,GEN1.GEN.omegaPu,GEN1.GEN.lambdaDPu,GEN1.GEN.lambdafPu,GEN1.GEN.lambdaQ1Pu,GEN1.GEN.lambdaQ2Pu,GEN2.GEN.theta,GEN2.GEN.omegaPu,GEN2.GEN.lambdaDPu,GEN2.GEN.lambdafPu,GEN2.GEN.lambdaQ1Pu,GEN2.GEN.lambdaQ2Pu,GEN3.GEN.theta,GEN3.GEN.omegaPu,GEN3.GEN.lambdaDPu,GEN3.GEN.lambdafPu,GEN3.GEN.lambdaQ1Pu,GEN3.GEN.lambdaQ2Pu,GEN6.GEN.theta,GEN6.GEN.omegaPu,GEN6.GEN.lambdaDPu,GEN6.GEN.lambdafPu,GEN6.GEN.lambdaQ1Pu,GEN6.GEN.lambdaQ2Pu,GEN8.GEN.theta,GEN8.GEN.omegaPu,GEN8.GEN.lambdaDPu,GEN8.GEN.lambdafPu,GEN8.GEN.lambdaQ1Pu,GEN8.GEN.lambdaQ2Pu)
 * Number of discrete variables: 57 ($whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,$whenCondition29,$whenCondition30,$whenCondition31,$whenCondition32,$whenCondition33,$whenCondition34,$whenCondition35,$whenCondition36,$whenCondition37,$whenCondition38,$whenCondition39,$whenCondition40,L1to5.breakerStatus,Tgen2.breakerStatus,GEN1.AVR.limiterWithLag.state,GEN1.AVR.limiterWithLag.saturationLimitReached,GEN1.AVR.limiterWithLag.satON,GEN2.AVR.limiterWithLag.state,GEN2.AVR.limiterWithLag.saturationLimitReached,GEN2.AVR.limiterWithLag.satON,GEN3.AVR.limiterWithLag.state,GEN3.AVR.limiterWithLag.saturationLimitReached,GEN3.AVR.limiterWithLag.satON,GEN6.AVR.limiterWithLag.state,GEN6.AVR.limiterWithLag.saturationLimitReached,GEN6.AVR.limiterWithLag.satON,GEN8.AVR.limiterWithLag.state,GEN8.AVR.limiterWithLag.saturationLimitReached,GEN8.AVR.limiterWithLag.satON)
 * Number of discrete states: 57 (Tgen2.breakerStatus,$whenCondition10,$whenCondition9,L1to5.breakerStatus,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,GEN3.AVR.limiterWithLag.satON,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,GEN3.AVR.limiterWithLag.saturationLimitReached,GEN3.AVR.limiterWithLag.state,$whenCondition23,GEN8.AVR.limiterWithLag.satON,$whenCondition40,$whenCondition39,$whenCondition38,$whenCondition37,$whenCondition36,GEN8.AVR.limiterWithLag.saturationLimitReached,GEN8.AVR.limiterWithLag.state,$whenCondition35,GEN6.AVR.limiterWithLag.satON,$whenCondition34,$whenCondition33,$whenCondition32,$whenCondition31,$whenCondition30,GEN6.AVR.limiterWithLag.saturationLimitReached,GEN6.AVR.limiterWithLag.state,$whenCondition29,GEN1.AVR.limiterWithLag.satON,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,GEN1.AVR.limiterWithLag.saturationLimitReached,GEN1.AVR.limiterWithLag.state,$whenCondition11,GEN2.AVR.limiterWithLag.satON,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,GEN2.AVR.limiterWithLag.saturationLimitReached,GEN2.AVR.limiterWithLag.state,$whenCondition17)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1189):
 * Single equations (assignments): 1181
 * Array equations: 0
 * Algorithm blocks: 7
 * 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
   {(63,429)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003279/2.904, allocations: 1.177 MB / 1.296 GB, free: 26.46 MB / 0.5418 GB
Notification: Performance of simCode: created initialization part: time 0.2459/3.15, allocations: 35.56 MB / 1.331 GB, free: 110 MB / 0.5574 GB
Notification: Performance of simCode: created event and clocks part: time 8.406e-06/3.15, allocations: 3.969 kB / 1.331 GB, free: 110 MB / 0.5574 GB
Notification: Performance of simCode: created simulation system equations: time 0.01533/3.165, allocations: 9.116 MB / 1.34 GB, free: 108.8 MB / 0.5574 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01901/3.184, allocations: 2.479 MB / 1.342 GB, free: 108.7 MB / 0.5574 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05736/3.242, allocations: 37.7 MB / 1.379 GB, free: 95.61 MB / 0.5574 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007836/3.25, allocations: 3.139 MB / 1.382 GB, free: 95.07 MB / 0.5574 GB
Notification: Performance of simCode: alias equations: time 0.009479/3.259, allocations: 2.006 MB / 1.384 GB, free: 94.59 MB / 0.5574 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004876/3.264, allocations: 1.12 MB / 1.385 GB, free: 94.58 MB / 0.5574 GB
Notification: Performance of SimCode: time 2.214e-06/3.264, allocations: 4 kB / 1.385 GB, free: 94.57 MB / 0.5574 GB
Notification: Performance of Templates: time 0.8301/4.094, allocations: 373.4 MB / 1.75 GB, free: 145.5 MB / 0.6043 GB
"
[Timeout remaining time 656]
make -j1 -f PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.makefile [Timeout 660]
(rm -f PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.pipe ; mkfifo PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.pipe ; head -c 1048576 < PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.pipe >> ../files/PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.sim & ./PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation.pipe 2>&1) [Timeout 240]
diffSimulationResults("PowerGrids_symb_jac_PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/PowerGrids/PowerGrids.Examples.IEEE14bus.IEEE14busLoad2Variation_res.mat","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 659]
Reference file matches
[Calling sys.exit(0), Time elapsed: 19.335407426115125]