Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/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/package.mo) Running command: "" <> buildModelFMU(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Examples_TwoAreas_Two_Areas_PSSE",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Examples_TwoAreas_Two_Areas_PSSE",fmuType="me",version="2.0",platforms={"static"}) Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.1036/0.1036, allocations: 12.21 MB / 27.33 MB, free: 1.441 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.001072/0.001072, allocations: 119.4 kB / 30.84 MB, free: 4.711 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.347/1.347, allocations: 205.1 MB / 239.3 MB, free: 13.05 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.001519/0.001519, allocations: 192.5 kB / 289.5 MB, free: 14.14 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.4223/0.4223, allocations: 78.51 MB / 418 MB, free: 12.02 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.0028/0.0028, allocations: 131.8 kB / 498.3 MB, free: 11.86 MB / 382.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.338/0.3408, allocations: 68.03 MB / 0.5531 GB, free: 32.57 MB / 398.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE): time 0.01341/0.3543, allocations: 15.8 MB / 0.5685 GB, free: 20.71 MB / 398.1 MB Notification: Performance of NFInst.instExpressions: time 0.009998/0.3643, allocations: 4.698 MB / 0.5731 GB, free: 16.77 MB / 398.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.00447/0.3688, allocations: 31 kB / 0.5731 GB, free: 16.77 MB / 398.1 MB Notification: Performance of NFTyping.typeComponents: time 0.00275/0.3716, allocations: 0.6261 MB / 0.5737 GB, free: 16.33 MB / 398.1 MB Notification: Performance of NFTyping.typeBindings: time 0.007624/0.3792, allocations: 2.172 MB / 0.5759 GB, free: 14.65 MB / 398.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00311/0.3824, allocations: 1.239 MB / 0.5771 GB, free: 13.75 MB / 398.1 MB Notification: Performance of NFFlatten.flatten: time 0.006644/0.389, allocations: 4.608 MB / 0.5816 GB, free: 11.05 MB / 398.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001432/0.3905, allocations: 0.7169 MB / 0.5823 GB, free: 10.37 MB / 398.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002701/0.3932, allocations: 1.66 MB / 0.5839 GB, free: 8.703 MB / 398.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002851/0.396, allocations: 2.275 MB / 0.5861 GB, free: 6.418 MB / 398.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001215/0.3973, allocations: 212 kB / 0.5863 GB, free: 6.211 MB / 398.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001947/0.3992, allocations: 431.7 kB / 0.5867 GB, free: 5.789 MB / 398.1 MB Notification: Performance of NFScalarize.scalarize: time 0.001215/0.4004, allocations: 0.7854 MB / 0.5875 GB, free: 5 MB / 398.1 MB Notification: Performance of NFVerifyModel.verify: time 0.002115/0.4026, allocations: 1.813 MB / 0.5893 GB, free: 3.176 MB / 398.1 MB Notification: Performance of NFConvertDAE.convert: time 0.003542/0.4061, allocations: 5.123 MB / 0.5943 GB, free: 14.03 MB / 414.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.32e-06/0.4061, allocations: 0 / 0.5943 GB, free: 14.03 MB / 414.1 MB Notification: Performance of FrontEnd: time 1.002e-06/0.4061, allocations: 0 / 0.5943 GB, free: 14.03 MB / 414.1 MB Notification: Performance of Transformations before backend: time 4.711e-05/0.4062, allocations: 0 / 0.5943 GB, free: 14.03 MB / 414.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 493 * Number of variables: 493 Notification: Performance of Generate backend data structure: time 0.03541/0.4416, allocations: 9.515 MB / 0.6036 GB, free: 4.445 MB / 414.1 MB Notification: Performance of prepare preOptimizeDAE: time 6.24e-05/0.4417, allocations: 11.98 kB / 0.6036 GB, free: 4.434 MB / 414.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003704/0.4421, allocations: 286.5 kB / 0.6039 GB, free: 4.145 MB / 414.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01018/0.4523, allocations: 1.751 MB / 0.6056 GB, free: 2.387 MB / 414.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003205/0.4555, allocations: 2.175 MB / 0.6077 GB, free: 156 kB / 414.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006785/0.4562, allocations: 0.6663 MB / 0.6083 GB, free: 15.39 MB / 430.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000387/0.4566, allocations: 239.8 kB / 0.6086 GB, free: 15.16 MB / 430.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.005304/0.4619, allocations: 2.689 MB / 0.6112 GB, free: 12.46 MB / 430.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 3.069e-05/0.4619, allocations: 0 / 0.6112 GB, free: 12.46 MB / 430.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002233/0.4621, allocations: 80 kB / 0.6113 GB, free: 12.38 MB / 430.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.465e-05/0.4622, allocations: 48 kB / 0.6113 GB, free: 12.34 MB / 430.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005675/0.4679, allocations: 2.826 MB / 0.6141 GB, free: 9.508 MB / 430.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.01697/0.4848, allocations: 11.07 MB / 0.6249 GB, free: 13.9 MB / 446.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.01136/0.4962, allocations: 4.963 MB / 0.6297 GB, free: 8.719 MB / 446.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.003614/0.4999, allocations: 1.935 MB / 0.6316 GB, free: 6.781 MB / 446.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0002458/0.5001, allocations: 49.88 kB / 0.6317 GB, free: 6.734 MB / 446.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.319e-05/0.5002, allocations: 56.56 kB / 0.6317 GB, free: 6.668 MB / 446.1 MB Notification: Performance of pre-optimization done (n=249): time 4.258e-06/0.5002, allocations: 0 / 0.6317 GB, free: 6.668 MB / 446.1 MB Notification: Performance of matching and sorting (n=249): time 0.1179/0.6181, allocations: 29.55 MB / 0.6606 GB, free: 9.047 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 6.09e-05/0.6182, allocations: 77.41 kB / 0.6607 GB, free: 8.961 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004273/0.6225, allocations: 2.902 MB / 0.6635 GB, free: 6.059 MB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0008193/0.6233, allocations: 85.7 kB / 0.6636 GB, free: 5.969 MB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0009638/0.6243, allocations: 1.256 MB / 0.6648 GB, free: 4.699 MB / 478.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.001106/0.6254, allocations: 0.9013 MB / 0.6657 GB, free: 3.785 MB / 478.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00129/0.6267, allocations: 0.7444 MB / 0.6664 GB, free: 3.027 MB / 478.1 MB Notification: Performance of setup shared object (initialization): time 0.0001016/0.6268, allocations: 309.1 kB / 0.6667 GB, free: 2.723 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.004635/0.6315, allocations: 2.284 MB / 0.6689 GB, free: 440 kB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.004853/0.6363, allocations: 2.677 MB / 0.6715 GB, free: 13.66 MB / 494.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.008813/0.6452, allocations: 4.851 MB / 0.6763 GB, free: 8.727 MB / 494.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.728e-06/0.6452, allocations: 4 kB / 0.6763 GB, free: 8.723 MB / 494.1 MB Notification: Performance of matching and sorting (n=531) (initialization): time 0.01451/0.6597, allocations: 7.221 MB / 0.6833 GB, free: 1.488 MB / 494.1 MB Notification: Performance of prepare postOptimizeDAE: time 3.084e-05/0.6597, allocations: 8 kB / 0.6833 GB, free: 1.48 MB / 494.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.71e-05/0.6598, allocations: 4 kB / 0.6834 GB, free: 1.477 MB / 494.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.01796/0.6777, allocations: 5.741 MB / 0.689 GB, free: 11.73 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003137/0.6809, allocations: 0.6593 MB / 0.6896 GB, free: 11.07 MB / 0.4981 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01261/0.6935, allocations: 5.45 MB / 0.6949 GB, free: 5.594 MB / 0.4981 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004223/0.6978, allocations: 0.5079 MB / 0.6954 GB, free: 5.082 MB / 0.4981 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003068/0.6981, allocations: 136 kB / 0.6955 GB, free: 4.949 MB / 0.4981 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 23 * 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 (410): * Single equations (assignments): 409 * Array equations: 0 * Algorithm blocks: 0 * 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 {(62,60)} Notification: Performance of prepare postOptimizeDAE: time 0.001129/0.6992, allocations: 0.5246 MB / 0.6961 GB, free: 4.414 MB / 0.4981 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005394/0.6998, allocations: 335.7 kB / 0.6964 GB, free: 4.082 MB / 0.4981 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03159/0.7314, allocations: 10.52 MB / 0.7067 GB, free: 9.48 MB / 0.5137 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.563e-05/0.7314, allocations: 27.94 kB / 0.7067 GB, free: 9.453 MB / 0.5137 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.045e-05/0.7314, allocations: 0 / 0.7067 GB, free: 9.453 MB / 0.5137 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.791e-05/0.7315, allocations: 11.95 kB / 0.7067 GB, free: 9.441 MB / 0.5137 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.2852/1.017, allocations: 14.65 MB / 0.721 GB, free: 135 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.368e-05/1.017, allocations: 1.219 kB / 0.721 GB, free: 135 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001678/1.018, allocations: 261 kB / 0.7212 GB, free: 135 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.01537/1.034, allocations: 4.762 MB / 0.7259 GB, free: 134.9 MB / 0.5137 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004613/1.034, allocations: 49.89 kB / 0.7259 GB, free: 134.9 MB / 0.5137 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04498/1.079, allocations: 19.61 MB / 0.7451 GB, free: 127.5 MB / 0.5137 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.286e-06/1.079, allocations: 3.375 kB / 0.7451 GB, free: 127.5 MB / 0.5137 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03568/1.115, allocations: 12.81 MB / 0.7576 GB, free: 120.7 MB / 0.5137 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001282/1.116, allocations: 499.7 kB / 0.7581 GB, free: 120.2 MB / 0.5137 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006927/1.117, allocations: 48 kB / 0.7581 GB, free: 120.2 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002802/1.12, allocations: 247.7 kB / 0.7584 GB, free: 119.9 MB / 0.5137 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00175/1.122, allocations: 0.5137 MB / 0.7589 GB, free: 119.4 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001791/1.122, allocations: 63.98 kB / 0.7589 GB, free: 119.4 MB / 0.5137 GB Notification: Performance of sorting global known variables: time 0.00228/1.124, allocations: 1.876 MB / 0.7608 GB, free: 117.5 MB / 0.5137 GB Notification: Performance of sort global known variables: time 2.7e-07/1.124, allocations: 0 / 0.7608 GB, free: 117.5 MB / 0.5137 GB Notification: Performance of remove unused functions: time 0.003095/1.127, allocations: 1.125 MB / 0.7619 GB, free: 116.4 MB / 0.5137 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 20 (g1.gENSAL.w,g1.gENSAL.delta,g1.gENSAL.Epq,g1.gENSAL.PSIkd,g1.gENSAL.PSIppq,g2.gENSAL.w,g2.gENSAL.delta,g2.gENSAL.Epq,g2.gENSAL.PSIkd,g2.gENSAL.PSIppq,g3.gENSAL.w,g3.gENSAL.delta,g3.gENSAL.Epq,g3.gENSAL.PSIkd,g3.gENSAL.PSIppq,g4.gENSAL.w,g4.gENSAL.delta,g4.gENSAL.Epq,g4.gENSAL.PSIkd,g4.gENSAL.PSIppq) * 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 (156): * Single equations (assignments): 155 * Array equations: 0 * Algorithm blocks: 0 * 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 {(54,52)} Notification: Performance of Backend phase and start with SimCode phase: time 0.03403/1.161, allocations: 13.24 MB / 0.7748 GB, free: 103.1 MB / 0.5137 GB Notification: Performance of simCode: created initialization part: time 0.01519/1.176, allocations: 6.094 MB / 0.7807 GB, free: 96.97 MB / 0.5137 GB Notification: Performance of simCode: created event and clocks part: time 5.23e-06/1.177, allocations: 0 / 0.7807 GB, free: 96.97 MB / 0.5137 GB Notification: Performance of simCode: created simulation system equations: time 0.009837/1.186, allocations: 3.703 MB / 0.7844 GB, free: 93.25 MB / 0.5137 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002806/1.189, allocations: 267.3 kB / 0.7846 GB, free: 92.98 MB / 0.5137 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07717/1.266, allocations: 44.31 MB / 0.8279 GB, free: 45.53 MB / 0.5137 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009598/1.267, allocations: 1.847 MB / 0.8297 GB, free: 43.66 MB / 0.5137 GB Notification: Performance of simCode: alias equations: time 0.001481/1.269, allocations: 292.9 kB / 0.83 GB, free: 43.37 MB / 0.5137 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001511/1.27, allocations: 1.386 MB / 0.8313 GB, free: 41.98 MB / 0.5137 GB Notification: Performance of SimCode: time 1.292e-06/1.27, allocations: 0 / 0.8313 GB, free: 41.98 MB / 0.5137 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1547/1.425, allocations: 82.43 MB / 0.9118 GB, free: 7.641 MB / 0.5606 GB Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002097/1.425, allocations: 217.8 kB / 0.912 GB, free: 7.387 MB / 0.5606 GB Notification: Performance of buildModelFMU: Generate platform static: time 4.706/6.131, allocations: 0 / 0.912 GB, free: 7.387 MB / 0.5606 GB (rm -f OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --tempDir=temp_OpenIPSL_2_0_0_OpenIPSL_Examples_TwoAreas_Two_Areas_PSSE_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=0.001 OpenIPSL_2_0_0_OpenIPSL_Examples_TwoAreas_Two_Areas_PSSE.fmu > OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE.pipe 2>&1)