Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.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/Complex 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/PowerGrids 2.0.0-develop/package.mo", uses=false)
Using package PowerGrids with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/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 Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 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(PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=100,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF")
translateModel(PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=100,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.005913/0.005913, allocations: 100.8 kB / 15.73 MB, free: 6.016 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00128/0.00128, allocations: 191.1 kB / 16.67 MB, free: 5.934 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.407/1.407, allocations: 222.9 MB / 240.4 MB, free: 15.08 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.08058/0.08058, allocations: 16.67 MB / 307.2 MB, free: 14.5 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001854/0.001854, allocations: 67.91 kB / 426.5 MB, free: 10.62 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1089/0.1107, allocations: 53.54 MB / 480.1 MB, free: 5.035 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF): time 0.3132/0.4239, allocations: 107.1 MB / 0.5734 GB, free: 4.148 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03908/0.4631, allocations: 19.93 MB / 0.5929 GB, free: 204 kB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009074/0.4722, allocations: 183.2 kB / 0.593 GB, free: 20 kB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00991/0.4821, allocations: 2.919 MB / 0.5959 GB, free: 13.08 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0287/0.5109, allocations: 8.345 MB / 0.604 GB, free: 4.797 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.009546/0.5204, allocations: 3.298 MB / 0.6073 GB, free: 1.562 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.02835/0.5488, allocations: 18.43 MB / 0.6252 GB, free: 15.07 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006213/0.5551, allocations: 2.974 MB / 0.6282 GB, free: 12.04 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01252/0.5676, allocations: 6.157 MB / 0.6342 GB, free: 5.855 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01176/0.5794, allocations: 6.463 MB / 0.6405 GB, free: 15.37 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.003294/0.5828, allocations: 0.7852 MB / 0.6412 GB, free: 14.58 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006717/0.5895, allocations: 1.754 MB / 0.643 GB, free: 12.83 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002351/0.5919, allocations: 1.855 MB / 0.6448 GB, free: 10.96 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.009362/0.6012, allocations: 5.738 MB / 0.6504 GB, free: 5.199 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02191/0.6232, allocations: 13.66 MB / 0.6637 GB, free: 7.492 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 1.157e-05/0.6232, allocations: 7.984 kB / 0.6637 GB, free: 7.484 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.373e-06/0.6232, allocations: 0 / 0.6637 GB, free: 7.484 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 0.0003767/0.6236, allocations: 4 kB / 0.6637 GB, free: 7.48 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1788
 * Number of variables: 1788
Notification: Performance of Generate backend data structure: time 0.0518/0.6754, allocations: 14.56 MB / 0.6779 GB, free: 8.762 MB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 4.887e-05/0.6755, allocations: 8.031 kB / 0.6779 GB, free: 8.754 MB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02173/0.6972, allocations: 2.379 MB / 0.6803 GB, free: 6.367 MB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0235/0.7207, allocations: 6.041 MB / 0.6862 GB, free: 264 kB / 0.5137 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001179/0.722, allocations: 0.6661 MB / 0.6868 GB, free: 15.57 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002409/0.7244, allocations: 0.7109 MB / 0.6875 GB, free: 14.86 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01794/0.7424, allocations: 8.265 MB / 0.6956 GB, free: 5.668 MB / 0.5294 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001423/0.7426, allocations: 47.5 kB / 0.6956 GB, free: 5.621 MB / 0.5294 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000746/0.7433, allocations: 320 kB / 0.6959 GB, free: 5.309 MB / 0.5294 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001675/0.7435, allocations: 187.9 kB / 0.6961 GB, free: 5.125 MB / 0.5294 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01277/0.7563, allocations: 6.923 MB / 0.7029 GB, free: 14.18 MB / 0.545 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 preOpt removeSimpleEquations (simulation): time 0.319/1.075, allocations: 53.86 MB / 0.7555 GB, free: 145.4 MB / 0.545 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0134/1.089, allocations: 8.667 MB / 0.7639 GB, free: 140.6 MB / 0.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00498/1.094, allocations: 2.852 MB / 0.7667 GB, free: 139.3 MB / 0.545 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004757/1.094, allocations: 99.59 kB / 0.7668 GB, free: 139.3 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004867/1.099, allocations: 3.429 MB / 0.7702 GB, free: 137.7 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=727): time 9.618e-06/1.099, allocations: 3.938 kB / 0.7702 GB, free: 137.7 MB / 0.545 GB
Notification: Performance of matching and sorting (n=727): time 0.04879/1.148, allocations: 15.65 MB / 0.7855 GB, free: 131.3 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001765/1.148, allocations: 0.6178 MB / 0.7861 GB, free: 130.7 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01303/1.161, allocations: 6.703 MB / 0.7926 GB, free: 127 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.001546/1.163, allocations: 173.7 kB / 0.7928 GB, free: 126.8 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003802/1.167, allocations: 3.531 MB / 0.7962 GB, free: 123.7 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003516/1.17, allocations: 2.923 MB / 0.7991 GB, free: 121.2 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008024/1.178, allocations: 3.54 MB / 0.8025 GB, free: 117.6 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 4.657e-05/1.178, allocations: 301.1 kB / 0.8028 GB, free: 117.3 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008036/1.186, allocations: 5.24 MB / 0.8079 GB, free: 112 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009685/1.196, allocations: 7.053 MB / 0.8148 GB, free: 104.7 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01391/1.21, allocations: 10.57 MB / 0.8251 GB, free: 93.72 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.74e-05/1.21, allocations: 4.875 kB / 0.8251 GB, free: 93.71 MB / 0.545 GB
Notification: Performance of matching and sorting (n=2563) (initialization): time 0.03944/1.25, allocations: 17.77 MB / 0.8425 GB, free: 75.78 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001308/1.25, allocations: 233.6 kB / 0.8427 GB, free: 75.5 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.061e-05/1.25, allocations: 23.98 kB / 0.8427 GB, free: 75.48 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01213/1.262, allocations: 2.735 MB / 0.8454 GB, free: 72.73 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01488/1.277, allocations: 3.901 MB / 0.8492 GB, free: 68.83 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03089/1.308, allocations: 22.11 MB / 0.8708 GB, free: 46.2 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01678/1.325, allocations: 1.227 MB / 0.872 GB, free: 45.21 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002303/1.327, allocations: 0.6093 MB / 0.8726 GB, free: 44.61 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 85
 * Number of states: 0 ()
 * Number of discrete variables: 33 (TRBo.componentPF.breakerStatusInInternal,TRBc.componentPF.breakerStatusInInternal,TRBc.breakerStatusInInternal,CloseCommand.y,TRBo.breakerStatusInInternal,BL2.componentPF.isSlackBus,IB2.componentPF.isSlackBus,LoadBo.componentPF.isSlackBus,IBL2.componentPF.isSlackBus,$PRE.TRBo.breakerStatusInInternal,$PRE.TRBo.componentPF.breakerStatusInInternal,TRBo.componentPF.breakerStatus,$PRE.TRBo.componentPF.breakerStatus,$whenCondition8,$whenCondition7,TRBo.breakerStatus,$PRE.TRBo.breakerStatus,$whenCondition6,$whenCondition5,IBL1.componentPF.isSlackBus,BL1.componentPF.isSlackBus,LoadBc.componentPF.isSlackBus,IB1.componentPF.isSlackBus,$PRE.TRBc.componentPF.breakerStatusInInternal,TRBc.componentPF.breakerStatus,$PRE.TRBc.componentPF.breakerStatus,$whenCondition4,$whenCondition3,$PRE.TRBc.breakerStatusInInternal,TRBc.breakerStatus,$PRE.TRBc.breakerStatus,$whenCondition2,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2373):
 * Single equations (assignments): 2361
 * Array equations: 0
 * Algorithm blocks: 8
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * 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): 4 systems
   {(45,0), (50,0), (45,0), (50,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.00458/1.332, allocations: 1.829 MB / 0.8744 GB, free: 42.75 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002009/1.334, allocations: 0.8618 MB / 0.8752 GB, free: 41.88 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01244/1.346, allocations: 7.82 MB / 0.8829 GB, free: 34.02 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.796e-05/1.346, allocations: 31.88 kB / 0.8829 GB, free: 33.99 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.247e-05/1.346, allocations: 0 / 0.8829 GB, free: 33.99 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005178/1.351, allocations: 1.795 MB / 0.8847 GB, free: 32.23 MB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002318/1.354, allocations: 124 kB / 0.8848 GB, free: 32.11 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006631/1.36, allocations: 270.4 kB / 0.885 GB, free: 31.84 MB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008805/1.361, allocations: 0.5499 MB / 0.8856 GB, free: 31.29 MB / 0.545 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01643/1.378, allocations: 8.382 MB / 0.8938 GB, free: 22.97 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01236/1.39, allocations: 8.78 MB / 0.9023 GB, free: 14.08 MB / 0.545 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003133/1.393, allocations: 2.284 MB / 0.9046 GB, free: 11.8 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.006361/1.4, allocations: 4.029 MB / 0.9085 GB, free: 7.809 MB / 0.545 GB
Notification: Performance of Backend: time 8.91e-07/1.4, allocations: 0 / 0.9085 GB, free: 7.809 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.03107/1.431, allocations: 14.16 MB / 0.9223 GB, free: 9.574 MB / 0.5606 GB
Notification: Performance of SimCode: time 0.2329/1.664, allocations: 14.98 MB / 0.937 GB, free: 181.3 MB / 0.5606 GB
Notification: Performance of Templates: time 0.1754/1.839, allocations: 128.3 MB / 1.062 GB, free: 84.38 MB / 0.5606 GB
make -j1 -f PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.makefile
(rm -f PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.pipe ; mkfifo PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.pipe >> ../files/PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.sim & ./PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF  -abortSlowSimulation -alarm=50 -lv LOG_STATS > PowerGrids_dev_PowerGrids.Electrical.Test.TestTransformerFixedRatioWithBreakersPF.pipe 2>&1)