Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.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: "" <> buildModelFMU(OpenIPSL.Examples.KundurSMIB.SMIB,fileNamePrefix="OpenIPSL_OpenIPSL_Examples_KundurSMIB_SMIB",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(OpenIPSL.Examples.KundurSMIB.SMIB,fileNamePrefix="OpenIPSL_OpenIPSL_Examples_KundurSMIB_SMIB",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.005893/0.005893, allocations: 101.5 kB / 15.73 MB, free: 6.016 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.264/1.264, allocations: 222.9 MB / 239.4 MB, free: 4.512 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.001298/0.001298, allocations: 188.5 kB / 289.7 MB, free: 2.223 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.4252/0.4252, allocations: 78.52 MB / 418.4 MB, free: 3.109 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001386/0.001386, allocations: 80.41 kB / 0.5531 GB, free: 1.465 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3185/0.3199, allocations: 68.18 MB / 0.6197 GB, free: 9.715 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.KundurSMIB.SMIB): time 0.004336/0.3243, allocations: 4.902 MB / 0.6245 GB, free: 5.539 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002462/0.3268, allocations: 1.587 MB / 0.626 GB, free: 3.949 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003807/0.3272, allocations: 12 kB / 0.6261 GB, free: 3.938 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003555/0.3276, allocations: 154.7 kB / 0.6262 GB, free: 3.785 MB / 430.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation transformer.m <> 1.0, <> on Real numbers is only allowed inside functions.
Notification: Performance of NFTyping.typeBindings: time 0.001235/0.3289, allocations: 0.6397 MB / 0.6268 GB, free: 3.145 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006417/0.3295, allocations: 429.9 kB / 0.6272 GB, free: 2.727 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0007929/0.3303, allocations: 1.082 MB / 0.6283 GB, free: 1.641 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002741/0.3306, allocations: 218 kB / 0.6285 GB, free: 1.414 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003851/0.331, allocations: 450.2 kB / 0.6289 GB, free: 0.9727 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004742/0.3315, allocations: 0.5485 MB / 0.6295 GB, free: 432 kB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001031/0.3316, allocations: 100 kB / 0.6296 GB, free: 332 kB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003354/0.3319, allocations: 235.8 kB / 0.6298 GB, free: 96 kB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001911/0.3321, allocations: 231.1 kB / 0.63 GB, free: 15.87 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003601/0.3325, allocations: 477.4 kB / 0.6305 GB, free: 15.4 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.001143/0.3336, allocations: 1.26 MB / 0.6317 GB, free: 14.14 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.811e-06/0.3337, allocations: 8 kB / 0.6317 GB, free: 14.13 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.044e-06/0.3337, allocations: 0 / 0.6317 GB, free: 14.13 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 1.251e-05/0.3337, allocations: 0 / 0.6317 GB, free: 14.13 MB / 446.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 121
 * Number of variables: 121
Notification: Performance of Generate backend data structure: time 0.005123/0.3388, allocations: 1.741 MB / 0.6334 GB, free: 12.33 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.679e-05/0.3389, allocations: 16.03 kB / 0.6334 GB, free: 12.32 MB / 446.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001093/0.339, allocations: 90.7 kB / 0.6335 GB, free: 12.22 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003187/0.3422, allocations: 0.5223 MB / 0.634 GB, free: 11.7 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008826/0.3431, allocations: 0.647 MB / 0.6346 GB, free: 11 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001826/0.3433, allocations: 142.1 kB / 0.6348 GB, free: 10.85 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001076/0.3434, allocations: 52 kB / 0.6348 GB, free: 10.8 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001257/0.3447, allocations: 0.6584 MB / 0.6355 GB, free: 10.13 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.465e-05/0.3447, allocations: 0 / 0.6355 GB, free: 10.13 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.764e-05/0.3447, allocations: 20 kB / 0.6355 GB, free: 10.11 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.499e-05/0.3448, allocations: 19.94 kB / 0.6355 GB, free: 10.09 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001182/0.3459, allocations: 0.6247 MB / 0.6361 GB, free: 9.469 MB / 446.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.004135/0.3501, allocations: 2.623 MB / 0.6387 GB, free: 6.727 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01217/0.3623, allocations: 2.817 MB / 0.6414 GB, free: 3.867 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009704/0.3633, allocations: 442.4 kB / 0.6419 GB, free: 3.43 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 8.494e-05/0.3634, allocations: 4.562 kB / 0.6419 GB, free: 3.422 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.891e-05/0.3634, allocations: 43.12 kB / 0.6419 GB, free: 3.371 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=57): time 2.966e-06/0.3634, allocations: 0 / 0.6419 GB, free: 3.371 MB / 446.1 MB
Notification: Performance of matching and sorting (n=57): time 0.01253/0.376, allocations: 3.527 MB / 0.6453 GB, free: 15.77 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.189e-05/0.3761, allocations: 67.91 kB / 0.6454 GB, free: 15.7 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001028/0.3771, allocations: 0.7584 MB / 0.6462 GB, free: 14.93 MB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001071/0.3772, allocations: 41.7 kB / 0.6462 GB, free: 14.88 MB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002356/0.3775, allocations: 348.6 kB / 0.6465 GB, free: 14.54 MB / 462.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001972/0.3777, allocations: 217 kB / 0.6467 GB, free: 14.32 MB / 462.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003122/0.378, allocations: 170.5 kB / 0.6469 GB, free: 14.15 MB / 462.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001558/0.3781, allocations: 394.7 kB / 0.6473 GB, free: 13.76 MB / 462.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009712/0.3791, allocations: 0.4939 MB / 0.6478 GB, free: 13.27 MB / 462.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00104/0.3802, allocations: 0.5952 MB / 0.6483 GB, free: 12.64 MB / 462.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01531/0.3955, allocations: 3.56 MB / 0.6518 GB, free: 9.055 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.697e-06/0.3955, allocations: 4 kB / 0.6518 GB, free: 9.051 MB / 462.1 MB
Notification: Performance of matching and sorting (n=114) (initialization): time 0.007261/0.4028, allocations: 2.388 MB / 0.6541 GB, free: 6.645 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.848e-05/0.4029, allocations: 10.5 kB / 0.6542 GB, free: 6.637 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.748e-06/0.4029, allocations: 0 / 0.6542 GB, free: 6.637 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004302/0.4072, allocations: 1.05 MB / 0.6552 GB, free: 5.578 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008002/0.408, allocations: 151.8 kB / 0.6553 GB, free: 5.43 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01053/0.4186, allocations: 5.071 MB / 0.6603 GB, free: 212 kB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00118/0.4198, allocations: 111.2 kB / 0.6604 GB, free: 100 kB / 462.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.088e-05/0.4199, allocations: 35.98 kB / 0.6604 GB, free: 64 kB / 462.1 MB
Warning: Assuming fixed start value for the following 2 variables:
         G1.machine.w:VARIABLE(flow=false start = 1.0 fixed = true )  "Rotor speed [pu]" type: Real
         G1.machine.delta:VARIABLE(flow=false start = G1.machine.delta0 unit = "rad" fixed = true )  "Rotor angle" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 8
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (93):
 * Single equations (assignments): 90
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 2 systems
   {(2,100.0%), (2,100.0%)}
 * Non-linear Jacobian (size): 0 systems
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(7,13,59.2%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0004561/0.4204, allocations: 214.2 kB / 0.6606 GB, free: 15.84 MB / 478.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001579/0.4205, allocations: 86.89 kB / 0.6607 GB, free: 15.76 MB / 478.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005892/0.4264, allocations: 1.941 MB / 0.6626 GB, free: 13.8 MB / 478.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.618e-06/0.4265, allocations: 4 kB / 0.6626 GB, free: 13.79 MB / 478.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.084e-06/0.4265, allocations: 4 kB / 0.6626 GB, free: 13.79 MB / 478.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.018e-05/0.4265, allocations: 4 kB / 0.6626 GB, free: 13.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 postOpt removeSimpleEquations (simulation): time 0.007118/0.4336, allocations: 3.044 MB / 0.6656 GB, free: 10.65 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.082e-06/0.4337, allocations: 0 / 0.6656 GB, free: 10.65 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000467/0.4341, allocations: 63.91 kB / 0.6656 GB, free: 10.59 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003287/0.4374, allocations: 0.9389 MB / 0.6666 GB, free: 9.637 MB / 478.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.825e-05/0.4376, allocations: 12 kB / 0.6666 GB, free: 9.625 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.008162/0.4457, allocations: 4.11 MB / 0.6706 GB, free: 5.375 MB / 478.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.837e-06/0.4458, allocations: 3.938 kB / 0.6706 GB, free: 5.371 MB / 478.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006952/0.4527, allocations: 2.519 MB / 0.6731 GB, free: 2.824 MB / 478.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003077/0.4531, allocations: 172 kB / 0.6732 GB, free: 2.637 MB / 478.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001133/0.4532, allocations: 12 kB / 0.6732 GB, free: 2.625 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007251/0.4539, allocations: 47.94 kB / 0.6733 GB, free: 2.578 MB / 478.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000328/0.4543, allocations: 120.4 kB / 0.6734 GB, free: 2.461 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.146e-05/0.4543, allocations: 23.97 kB / 0.6734 GB, free: 2.438 MB / 478.1 MB
Notification: Performance of sorting global known variables: time 0.0006177/0.4549, allocations: 0.5147 MB / 0.6739 GB, free: 1.926 MB / 478.1 MB
Notification: Performance of sort global known variables: time 1.31e-07/0.455, allocations: 4.188 kB / 0.6739 GB, free: 1.922 MB / 478.1 MB
Notification: Performance of remove unused functions: time 0.0009115/0.4559, allocations: 299.7 kB / 0.6742 GB, free: 1.629 MB / 478.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 6 (G1.machine.delta,G1.machine.w,G1.machine.e1q,G1.machine.e1d,G1.machine.e2q,G1.machine.e2d)
 * 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 (40):
 * Single equations (assignments): 37
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 2 systems
   {(2,100.0%), (2,100.0%)}
 * Non-linear Jacobian (size): 0 systems
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(9,9,48.1%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.007253/0.4631, allocations: 3.082 MB / 0.6772 GB, free: 14.51 MB / 494.1 MB
Notification: Performance of simCode: created initialization part: time 0.004474/0.4676, allocations: 1.731 MB / 0.6789 GB, free: 12.72 MB / 494.1 MB
Notification: Performance of simCode: created event and clocks part: time 5.761e-06/0.4677, allocations: 4.438 kB / 0.6789 GB, free: 12.72 MB / 494.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.002756/0.4704, allocations: 1.072 MB / 0.68 GB, free: 11.59 MB / 494.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0006644/0.4711, allocations: 72.83 kB / 0.68 GB, free: 11.52 MB / 494.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02131/0.4925, allocations: 9.881 MB / 0.6897 GB, free: 1.457 MB / 494.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004816/0.493, allocations: 0.9499 MB / 0.6906 GB, free: 488 kB / 494.1 MB
Notification: Performance of simCode: alias equations: time 0.0003655/0.4934, allocations: 69.12 kB / 0.6907 GB, free: 416 kB / 494.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004117/0.4938, allocations: 287.3 kB / 0.6909 GB, free: 128 kB / 494.1 MB
Notification: Performance of SimCode: time 1.132e-06/0.4938, allocations: 0 / 0.6909 GB, free: 128 kB / 494.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.04714/0.5409, allocations: 22.28 MB / 0.7127 GB, free: 9.941 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate platform static: time 11.72/12.26, allocations: 9.469 kB / 0.7127 GB, free: 9.934 MB / 0.5137 GB
(rm -f OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.pipe ; mkfifo OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.pipe >> ../files/OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_OpenIPSL_OpenIPSL_Examples_KundurSMIB_SMIB_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=1e-06 OpenIPSL_OpenIPSL_Examples_KundurSMIB_SMIB.fmu > OpenIPSL_OpenIPSL.Examples.KundurSMIB.SMIB.pipe 2>&1)