Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+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/ModelicaServices 3.2.3+maint.om/package.mo", uses=false) 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/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 Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo) Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+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 Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo) Running command: "" <> buildModelFMU(OpenIPSL.Examples.IEEE14.IEEE_14_Buses,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Examples_IEEE14_IEEE_14_Buses",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(OpenIPSL.Examples.IEEE14.IEEE_14_Buses,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Examples_IEEE14_IEEE_14_Buses",fmuType="me",version="2.0",platforms={"static"}) [:1:1-1:32:writable] Error: Class GC_set_max_heap_size not found in scope (looking for a function or record). Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002443/0.002443, allocations: 183.7 kB / 7.459 MB, free: 2.512 MB / 5.871 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.058/1.058, allocations: 205.2 MB / 213.1 MB, free: 13.92 MB / 186.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008305/0.0008306, allocations: 89.36 kB / 261.1 MB, free: 13.55 MB / 218.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.05874/0.05874, allocations: 12.19 MB / 321.2 MB, free: 1.305 MB / 266.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.2681/0.2681, allocations: 78.05 MB / 449.9 MB, free: 3.648 MB / 298.7 MB Notification: Performance of FrontEnd - loaded program: time 0.2242/0.4923, allocations: 76.08 MB / 0.5137 GB, free: 30.33 MB / 330.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1066/0.599, allocations: 69.23 MB / 0.5813 GB, free: 9.184 MB / 378.7 MB Notification: Performance of FrontEnd - scodeFlatten: time 0.3068/0.9058, allocations: 105.9 MB / 0.6847 GB, free: 3.188 MB / 426.7 MB Notification: Performance of FrontEnd - mkProgramGraph: time 0.0001513/0.906, allocations: 70.91 kB / 0.6847 GB, free: 3.152 MB / 426.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 885 * Number of variables: 885 Notification: Performance of Generate backend data structure: time 0.3805/1.287, allocations: 140.7 MB / 0.8221 GB, free: 0.6406 MB / 0.5417 GB Notification: Performance of prepare preOptimizeDAE: time 3.994e-05/1.287, allocations: 11.94 kB / 0.8221 GB, free: 0.6289 MB / 0.5417 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01625/1.303, allocations: 2.482 MB / 0.8246 GB, free: 14.14 MB / 0.5573 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.008217/1.311, allocations: 3.262 MB / 0.8278 GB, free: 10.81 MB / 0.5573 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009527/1.312, allocations: 0.8596 MB / 0.8286 GB, free: 9.816 MB / 0.5573 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001164/1.313, allocations: 223.8 kB / 0.8288 GB, free: 9.598 MB / 0.5573 GB Notification: Performance of preOpt removeEqualFunctionCalls (simulation): time 0.008397/1.322, allocations: 3.935 MB / 0.8326 GB, free: 5.66 MB / 0.5573 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.008058/1.33, allocations: 3.904 MB / 0.8365 GB, free: 1.715 MB / 0.5573 GB Notification: Performance of preOpt findStateOrder (simulation): time 6.523e-05/1.33, allocations: 0 / 0.8365 GB, free: 1.715 MB / 0.5573 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004016/1.33, allocations: 3.984 kB / 0.8365 GB, free: 1.711 MB / 0.5573 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.208e-05/1.33, allocations: 84 kB / 0.8365 GB, free: 1.629 MB / 0.5573 GB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.2109/1.541, allocations: 17.59 MB / 0.8537 GB, free: 176 MB / 0.573 GB Notification: Performance of preOpt comSubExp (simulation): time 0.007251/1.549, allocations: 4.194 MB / 0.8578 GB, free: 175.8 MB / 0.573 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.003838/1.552, allocations: 2.747 MB / 0.8605 GB, free: 175.7 MB / 0.573 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0004372/1.553, allocations: 77.45 kB / 0.8606 GB, free: 175.7 MB / 0.573 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004394/1.557, allocations: 3.023 MB / 0.8635 GB, free: 175.6 MB / 0.573 GB Notification: Performance of pre-optimization done (n=476): time 6.181e-06/1.557, allocations: 3.625 kB / 0.8635 GB, free: 175.6 MB / 0.573 GB Notification: Performance of matching and sorting (n=476): time 0.05252/1.61, allocations: 17.52 MB / 0.8806 GB, free: 175.3 MB / 0.573 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001253/1.61, allocations: 367.7 kB / 0.881 GB, free: 174.9 MB / 0.573 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005744/1.616, allocations: 3.563 MB / 0.8845 GB, free: 174.6 MB / 0.573 GB Notification: Performance of collectPreVariables (initialization): time 0.001105/1.617, allocations: 32.61 kB / 0.8845 GB, free: 174.6 MB / 0.573 GB Notification: Performance of collectInitialEqns (initialization): time 0.0005408/1.617, allocations: 1.107 MB / 0.8856 GB, free: 174.2 MB / 0.573 GB Notification: Performance of collectInitialBindings (initialization): time 0.003487/1.621, allocations: 1.598 MB / 0.8871 GB, free: 173.4 MB / 0.573 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003732/1.621, allocations: 0 / 0.8871 GB, free: 173.4 MB / 0.573 GB Notification: Performance of setup shared object (initialization): time 0.0002077/1.622, allocations: 491.1 kB / 0.8876 GB, free: 173.1 MB / 0.573 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003527/1.625, allocations: 2.22 MB / 0.8898 GB, free: 173.1 MB / 0.573 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.003759/1.629, allocations: 2.645 MB / 0.8924 GB, free: 172.8 MB / 0.573 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.003989/1.633, allocations: 2.475 MB / 0.8948 GB, free: 172.6 MB / 0.573 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.182e-05/1.633, allocations: 7.688 kB / 0.8948 GB, free: 172.6 MB / 0.573 GB Notification: Performance of matching and sorting (n=608) (initialization): time 0.05197/1.685, allocations: 17.45 MB / 0.9118 GB, free: 171.1 MB / 0.573 GB Notification: Performance of prepare postOptimizeDAE: time 2.02e-05/1.685, allocations: 2.906 kB / 0.9118 GB, free: 171.1 MB / 0.573 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.027e-05/1.685, allocations: 6.656 kB / 0.9118 GB, free: 171.1 MB / 0.573 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.03138/1.716, allocations: 9.385 MB / 0.921 GB, free: 170.4 MB / 0.573 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004811/1.721, allocations: 0.7501 MB / 0.9217 GB, free: 170.4 MB / 0.573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.07539/1.797, allocations: 30.61 MB / 0.9516 GB, free: 148.4 MB / 0.573 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008026/1.805, allocations: 0.7281 MB / 0.9523 GB, free: 147.8 MB / 0.573 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001394/1.806, allocations: 165.2 kB / 0.9525 GB, free: 147.7 MB / 0.573 GB Warning: Assuming fixed start value for the following 11 variables: groupBus1_1.Syn1.e2d:VARIABLE(start = groupBus1_1.Syn1.e2d0 unit = "1" ) "d-axis sub-transient voltage" type: Real groupBus1_1.Syn1.e2q:VARIABLE(start = groupBus1_1.Syn1.e2q0 unit = "1" ) "q-axis sub-transient voltage" type: Real groupBus1_1.Syn1.e1q:VARIABLE(start = groupBus1_1.Syn1.e1q0 unit = "1" ) "q-axis transient voltage" type: Real groupBus1_1.Syn1.w:VARIABLE(start = 1.0 ) "Rotor speed [pu]" type: Real groupBus1_1.Syn1.delta:VARIABLE(start = groupBus1_1.Syn1.delta0 unit = "rad" ) "Rotor angle" type: Real groupBus8_1.Syn4.e2d:VARIABLE(start = groupBus8_1.Syn4.e2d0 unit = "1" ) "d-axis sub-transient voltage" type: Real groupBus8_1.Syn4.w:VARIABLE(start = 1.0 ) "Rotor speed [pu]" type: Real groupBus8_1.Syn4.delta:VARIABLE(start = groupBus8_1.Syn4.delta0 unit = "rad" ) "Rotor angle" type: Real groupBus6_1.Syn5.w:VARIABLE(start = 1.0 ) "Rotor speed [pu]" type: Real groupBus3_1.Syn2.w:VARIABLE(start = 1.0 ) "Rotor speed [pu]" type: Real groupBus2_1.Syn3.w:VARIABLE(start = 1.0 ) "Rotor speed [pu]" type: Real Warning: Iteration variables with default zero start attribute in torn nonlinear equation system: lPQ3.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real lPQ2.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real lPQ4.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real lPQ9.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real lPQ5.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real lPQ12.a:VARIABLE(protected = true ) "Auxiliary variable, voltage division" type: Real Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 29 * Number of states: 0 () * Number of discrete variables: 10 ($whenCondition9,$whenCondition10,$whenCondition7,$whenCondition8,$whenCondition5,$whenCondition6,$whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (404): * Single equations (assignments): 392 * Array equations: 0 * Algorithm blocks: 10 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (linear and non-linear blocks): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 1 {(1,100.0%) 1} * Non-linear torn systems: 1 {98 106} Notification: Performance of prepare postOptimizeDAE: time 0.002349/1.808, allocations: 338.9 kB / 0.9528 GB, free: 147.4 MB / 0.573 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00196/1.81, allocations: 0.5594 MB / 0.9534 GB, free: 146.8 MB / 0.573 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05031/1.861, allocations: 17.98 MB / 0.9709 GB, free: 132.7 MB / 0.573 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.955e-05/1.861, allocations: 48 kB / 0.971 GB, free: 132.6 MB / 0.573 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.989e-06/1.861, allocations: 4 kB / 0.971 GB, free: 132.6 MB / 0.573 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.000115/1.861, allocations: 21.14 kB / 0.971 GB, free: 132.6 MB / 0.573 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06029/1.921, allocations: 25.36 MB / 0.9958 GB, free: 112.8 MB / 0.573 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.844e-05/1.921, allocations: 0 / 0.9958 GB, free: 112.8 MB / 0.573 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003149/1.924, allocations: 410.1 kB / 0.9961 GB, free: 112.5 MB / 0.573 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.02893/1.953, allocations: 10.35 MB / 1.006 GB, free: 103.8 MB / 0.573 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001319/1.955, allocations: 46.22 kB / 1.006 GB, free: 103.8 MB / 0.573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.06576/2.021, allocations: 33.35 MB / 1.039 GB, free: 73.2 MB / 0.573 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.35e-06/2.021, allocations: 10.06 kB / 1.039 GB, free: 73.2 MB / 0.573 GB Notification: Performance of postOpt detectJacobianSparsePattern (simulation): time 0.05701/2.078, allocations: 21.67 MB / 1.06 GB, free: 54.98 MB / 0.573 GB Notification: Performance of postOpt generateSymbolicLinearization (simulation): time 0.06313/2.141, allocations: 25.71 MB / 1.085 GB, free: 31.65 MB / 0.573 GB Notification: Performance of postOpt removeConstants (simulation): time 0.002008/2.143, allocations: 0.7718 MB / 1.086 GB, free: 30.92 MB / 0.573 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001995/2.145, allocations: 23.98 kB / 1.086 GB, free: 30.89 MB / 0.573 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006169/2.151, allocations: 0.5104 MB / 1.086 GB, free: 30.39 MB / 0.573 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001629/2.153, allocations: 487 kB / 1.087 GB, free: 29.91 MB / 0.573 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004195/2.153, allocations: 132 kB / 1.087 GB, free: 29.78 MB / 0.573 GB Notification: Performance of sort global known variables: time 0.003834/2.157, allocations: 2.65 MB / 1.09 GB, free: 27.15 MB / 0.573 GB Notification: Performance of remove unused functions: time 0.006437/2.163, allocations: 1.798 MB / 1.091 GB, free: 25.38 MB / 0.573 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 6 * Number of states: 49 (groupBus2_1.aVR1TypeII1.ExcitationSystem.x_scaled[1],groupBus2_1.aVR1TypeII1.derivativeBlock.x,groupBus2_1.aVR1TypeII1.firstOrder2.y,groupBus2_1.aVR1TypeII1.simpleLagLim.state,groupBus2_1.Syn3.delta,groupBus2_1.Syn3.w,groupBus2_1.Syn3.e1q,groupBus2_1.Syn3.e1d,groupBus2_1.Syn3.e2q,groupBus2_1.Syn3.e2d,groupBus3_1.aVR2TypeII2.ExcitationSystem.x_scaled[1],groupBus3_1.aVR2TypeII2.derivativeBlock.x,groupBus3_1.aVR2TypeII2.firstOrder2.y,groupBus3_1.aVR2TypeII2.simpleLagLim.state,groupBus3_1.Syn2.delta,groupBus3_1.Syn2.w,groupBus3_1.Syn2.e1q,groupBus3_1.Syn2.e1d,groupBus3_1.Syn2.e2q,groupBus3_1.Syn2.e2d,groupBus6_1.aVR4TypeII1.ExcitationSystem.x_scaled[1],groupBus6_1.aVR4TypeII1.derivativeBlock.x,groupBus6_1.aVR4TypeII1.firstOrder2.y,groupBus6_1.aVR4TypeII1.simpleLagLim.state,groupBus6_1.Syn5.delta,groupBus6_1.Syn5.w,groupBus6_1.Syn5.e1q,groupBus6_1.Syn5.e1d,groupBus6_1.Syn5.e2q,groupBus6_1.Syn5.e2d,groupBus8_1.aVR3TypeII2.ExcitationSystem.x_scaled[1],groupBus8_1.aVR3TypeII2.derivativeBlock.x,groupBus8_1.aVR3TypeII2.firstOrder2.y,groupBus8_1.aVR3TypeII2.simpleLagLim.state,groupBus8_1.Syn4.delta,groupBus8_1.Syn4.w,groupBus8_1.Syn4.e1q,groupBus8_1.Syn4.e1d,groupBus8_1.Syn4.e2q,groupBus8_1.Syn4.e2d,groupBus1_1.AVR1.ExcitationSystem.x_scaled[1],groupBus1_1.AVR1.derivativeBlock.x,groupBus1_1.AVR1.firstOrder2.y,groupBus1_1.AVR1.simpleLagLim.state,groupBus1_1.Syn1.delta,groupBus1_1.Syn1.w,groupBus1_1.Syn1.e1q,groupBus1_1.Syn1.e2q,groupBus1_1.Syn1.e2d) * Number of discrete variables: 10 ($whenCondition9,$whenCondition10,$whenCondition7,$whenCondition8,$whenCondition5,$whenCondition6,$whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (258): * Single equations (assignments): 247 * Array equations: 0 * Algorithm blocks: 5 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (linear and non-linear blocks): 0 * Torn equation systems: 6 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 0 * Non-linear torn systems: 6 {110 94,1 6,1 6,1 6,1 6,1 6} Notification: Performance of Backend phase and start with SimCode phase: time 0.0006758/2.164, allocations: 190.5 kB / 1.092 GB, free: 25.22 MB / 0.573 GB Notification: Performance of simCode: created initialization part: time 0.02157/2.186, allocations: 9.205 MB / 1.101 GB, free: 15.98 MB / 0.573 GB Notification: Performance of simCode: created event and clocks part: time 5.801e-06/2.186, allocations: 0 / 1.101 GB, free: 15.98 MB / 0.573 GB Notification: Performance of simCode: created simulation system equations: time 0.01773/2.203, allocations: 7.02 MB / 1.107 GB, free: 8.914 MB / 0.573 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003243/2.207, allocations: 374 kB / 1.108 GB, free: 8.555 MB / 0.573 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1842/2.391, allocations: 9.405 MB / 1.117 GB, free: 161.1 MB / 0.573 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004476/2.395, allocations: 3.344 MB / 1.12 GB, free: 160.3 MB / 0.573 GB Notification: Performance of SimCode: time 1.703e-06/2.395, allocations: 0 / 1.12 GB, free: 160.3 MB / 0.573 GB (rm -f OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator --tempDir=temp_OpenIPSL_2_0_0_OpenIPSL_Examples_IEEE14_IEEE_14_Buses_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=1e-06 OpenIPSL_2_0_0_OpenIPSL_Examples_IEEE14_IEEE_14_Buses.fmu > OpenIPSL_2.0.0_OpenIPSL.Examples.IEEE14.IEEE_14_Buses.pipe 2>&1)