Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.conf.json 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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo", uses=false) Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/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 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) Running command: "" <> buildModelFMU(OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Examples_Tutorial_Example_4_Experiments_SMIBVarLoad",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Examples_Tutorial_Example_4_Experiments_SMIBVarLoad",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 4.0.0+maint.om/package.mo): time 0.003023/0.003023, allocations: 183.2 kB / 7.461 MB, free: 2.5 MB / 5.871 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.286/1.286, allocations: 221.4 MB / 229.3 MB, free: 3.086 MB / 186.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001256/0.001256, allocations: 87.95 kB / 280.1 MB, free: 1.301 MB / 218.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.4331/0.4331, allocations: 78.92 MB / 409.8 MB, free: 14.98 MB / 298.7 MB Notification: Performance of FrontEnd - loaded program: time 0.1847/0.6179, allocations: 75.66 MB / 485.5 MB, free: 3.562 MB / 362.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.379/0.9969, allocations: 69.49 MB / 0.542 GB, free: 20.98 MB / 378.7 MB Notification: Performance of FrontEnd - scodeFlatten: time 0.1572/1.154, allocations: 123.2 MB / 0.6623 GB, free: 12.8 MB / 490.7 MB Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003363/1.155, allocations: 87.94 kB / 0.6624 GB, free: 12.71 MB / 490.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 445 * Number of variables: 445 Notification: Performance of Generate backend data structure: time 0.4984/1.653, allocations: 91.48 MB / 0.7517 GB, free: 58.89 MB / 490.7 MB Notification: Performance of prepare preOptimizeDAE: time 3.456e-05/1.653, allocations: 8 kB / 0.7517 GB, free: 58.89 MB / 490.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004436/1.658, allocations: 0.6865 MB / 0.7524 GB, free: 58.2 MB / 490.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.007078/1.665, allocations: 2.576 MB / 0.7549 GB, free: 55.56 MB / 490.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001016/1.666, allocations: 0.7854 MB / 0.7556 GB, free: 54.62 MB / 490.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.00146/1.667, allocations: 123.9 kB / 0.7558 GB, free: 54.5 MB / 490.7 MB Notification: Performance of preOpt removeEqualFunctionCalls (simulation): time 0.006033/1.673, allocations: 2.467 MB / 0.7582 GB, free: 52.04 MB / 490.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.005659/1.679, allocations: 2.173 MB / 0.7603 GB, free: 49.82 MB / 490.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 5.502e-05/1.679, allocations: 0 / 0.7603 GB, free: 49.82 MB / 490.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003631/1.679, allocations: 0 / 0.7603 GB, free: 49.82 MB / 490.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.147e-05/1.679, allocations: 44 kB / 0.7603 GB, free: 49.78 MB / 490.7 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01879/1.698, allocations: 9.778 MB / 0.7699 GB, free: 39.77 MB / 490.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.00383/1.702, allocations: 2.34 MB / 0.7722 GB, free: 37.43 MB / 490.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001622/1.704, allocations: 1.307 MB / 0.7734 GB, free: 36.12 MB / 490.7 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0001784/1.704, allocations: 45.89 kB / 0.7735 GB, free: 36.08 MB / 490.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002061/1.706, allocations: 1.561 MB / 0.775 GB, free: 34.5 MB / 490.7 MB Notification: Performance of pre-optimization done (n=217): time 4.258e-06/1.706, allocations: 0 / 0.775 GB, free: 34.5 MB / 490.7 MB Notification: Performance of matching and sorting (n=217): time 0.01636/1.722, allocations: 6.213 MB / 0.7811 GB, free: 28.26 MB / 490.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 6.355e-05/1.722, allocations: 209.9 kB / 0.7813 GB, free: 28.01 MB / 490.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004281/1.727, allocations: 2.537 MB / 0.7838 GB, free: 25.47 MB / 490.7 MB Notification: Performance of collectPreVariables (initialization): time 0.0005068/1.727, allocations: 25.7 kB / 0.7838 GB, free: 25.44 MB / 490.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.0003622/1.728, allocations: 0.6474 MB / 0.7844 GB, free: 24.78 MB / 490.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.00125/1.729, allocations: 0.735 MB / 0.7851 GB, free: 24.03 MB / 490.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001552/1.729, allocations: 4.031 kB / 0.7851 GB, free: 24.03 MB / 490.7 MB Notification: Performance of setup shared object (initialization): time 0.000103/1.729, allocations: 394.3 kB / 0.7855 GB, free: 23.64 MB / 490.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001735/1.731, allocations: 1.215 MB / 0.7867 GB, free: 22.42 MB / 490.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001799/1.733, allocations: 1.435 MB / 0.7881 GB, free: 20.93 MB / 490.7 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.002007/1.735, allocations: 1.351 MB / 0.7894 GB, free: 19.54 MB / 490.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.875e-06/1.735, allocations: 4 kB / 0.7894 GB, free: 19.54 MB / 490.7 MB Notification: Performance of matching and sorting (n=284) (initialization): time 0.00575/1.741, allocations: 3.58 MB / 0.7929 GB, free: 15.91 MB / 490.7 MB Notification: Performance of prepare postOptimizeDAE: time 0.0002377/1.741, allocations: 1.17 MB / 0.7941 GB, free: 14.62 MB / 490.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.28e-05/1.741, allocations: 4 kB / 0.7941 GB, free: 14.62 MB / 490.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.007003/1.748, allocations: 2.109 MB / 0.7961 GB, free: 12.5 MB / 490.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006855/1.755, allocations: 1.315 MB / 0.7974 GB, free: 11.19 MB / 490.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008447/1.763, allocations: 9.596 MB / 0.8068 GB, free: 1.047 MB / 490.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005658/1.769, allocations: 0.5136 MB / 0.8073 GB, free: 0.5312 MB / 490.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007343/1.77, allocations: 79.97 kB / 0.8074 GB, free: 464 kB / 490.7 MB Notification: Performance of prepare postOptimizeDAE: time 1.299e-05/1.77, allocations: 4 kB / 0.8074 GB, free: 460 kB / 490.7 MB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006436/1.776, allocations: 3.204 MB / 0.8105 GB, free: 13.2 MB / 0.4948 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.107e-06/1.776, allocations: 3.938 kB / 0.8105 GB, free: 13.2 MB / 0.4948 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.00787/1.784, allocations: 2.109 MB / 0.8126 GB, free: 11.09 MB / 0.4948 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006242/1.79, allocations: 0.8622 MB / 0.8134 GB, free: 10.22 MB / 0.4948 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01041/1.801, allocations: 7.539 MB / 0.8208 GB, free: 2.203 MB / 0.4948 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005162/1.806, allocations: 481.9 kB / 0.8212 GB, free: 1.73 MB / 0.4948 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003909/1.806, allocations: 79.97 kB / 0.8213 GB, free: 1.652 MB / 0.4948 GB Warning: Assuming fixed start value for the following 6 variables: genunit.eSST1A1.VA0:VARIABLE(fixed = false protected = true ) type: Real genunit.pSS2A.rampTrackingFilter.TF2[1].x_scaled[1]:VARIABLE(protected = true ) "Scaled vector x" type: Real [1,1] genunit.pSS2A.rampTrackingFilter.TF1[5].x_scaled[1]:VARIABLE(protected = true ) "Scaled vector x" type: Real [5,1] genunit.pSS2A.rampTrackingFilter.TF1[4].x_scaled[1]:VARIABLE(protected = true ) "Scaled vector x" type: Real [5,1] genunit.pSS2A.rampTrackingFilter.TF1[3].x_scaled[1]:VARIABLE(protected = true ) "Scaled vector x" type: Real [5,1] genunit.pSS2A.rampTrackingFilter.TF1[2].x_scaled[1]:VARIABLE(protected = true ) "Scaled vector x" type: Real [5,1] Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.lV_GATE.y:VARIABLE() "Connector of Real output signal" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.hV_GATE1.y:VARIABLE() "Connector of Real output signal" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.add3_2.y:VARIABLE() "Connector of Real output signal" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.imLeadLag1.y:VARIABLE() "Connector of Real output signal" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.hV_GATE.u1:VARIABLE() "Connector of Real input signal 1" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.eSST1A1.add3_1.y:VARIABLE() "Connector of Real output signal" type: Real Warning: Iteration variables with default zero start attribute in equation system w/o analytic Jacobian: genunit.pSS2A.Leadlag2.y:VARIABLE() "Connector of Real output signal" type: Real Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 12 * Number of states: 0 () * Number of discrete variables: 3 ($whenCondition1,$whenCondition2,genunit.iEEEG1_1.limIntegrator.local_reset) * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (233): * Single equations (assignments): 225 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (linear and non-linear blocks): 7 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details: * Constant Jacobian: 0 * Linear Jacobian (size,density): 0 * Non-linear Jacobian: 7 {1,1,1,1,1,1,1} * Without analytic Jacobian: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 0 * Non-linear torn systems: 1 {26 26} Notification: Performance of prepare postOptimizeDAE: time 0.0007669/1.807, allocations: 180.6 kB / 0.8215 GB, free: 1.477 MB / 0.4948 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008795/1.808, allocations: 308.2 kB / 0.8218 GB, free: 1.172 MB / 0.4948 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0182/1.826, allocations: 6.381 MB / 0.828 GB, free: 10.77 MB / 0.5105 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.054e-05/1.826, allocations: 20 kB / 0.828 GB, free: 10.75 MB / 0.5105 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.749e-06/1.826, allocations: 0 / 0.828 GB, free: 10.75 MB / 0.5105 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.172e-05/1.826, allocations: 11.95 kB / 0.828 GB, free: 10.74 MB / 0.5105 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02633/1.853, allocations: 10.19 MB / 0.838 GB, free: 456 kB / 0.5105 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.836e-05/1.853, allocations: 4 kB / 0.838 GB, free: 452 kB / 0.5105 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002956/1.856, allocations: 367.6 kB / 0.8383 GB, free: 84 kB / 0.5105 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.006694/1.862, allocations: 1.957 MB / 0.8402 GB, free: 14.12 MB / 0.5261 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000608/1.863, allocations: 43.88 kB / 0.8403 GB, free: 14.07 MB / 0.5261 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02118/1.884, allocations: 9.144 MB / 0.8492 GB, free: 4.688 MB / 0.5261 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.683e-06/1.884, allocations: 96 / 0.8492 GB, free: 4.688 MB / 0.5261 GB Notification: Performance of postOpt detectJacobianSparsePattern (simulation): time 0.02279/1.907, allocations: 8.31 MB / 0.8573 GB, free: 12.33 MB / 0.5417 GB Notification: Performance of postOpt generateSymbolicLinearization (simulation): time 0.02555/1.933, allocations: 10.62 MB / 0.8677 GB, free: 1.664 MB / 0.5417 GB Notification: Performance of postOpt removeConstants (simulation): time 0.00181/1.935, allocations: 0.5083 MB / 0.8682 GB, free: 1.133 MB / 0.5417 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001036/1.936, allocations: 27.98 kB / 0.8682 GB, free: 1.105 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003987/1.94, allocations: 427.5 kB / 0.8686 GB, free: 0.6875 MB / 0.5417 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005847/1.94, allocations: 209.6 kB / 0.8688 GB, free: 496 kB / 0.5417 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002011/1.94, allocations: 55.98 kB / 0.8689 GB, free: 440 kB / 0.5417 GB Notification: Performance of sort global known variables: time 0.003547/1.944, allocations: 1.905 MB / 0.8707 GB, free: 14.52 MB / 0.5573 GB Notification: Performance of remove unused functions: time 0.005391/1.949, allocations: 1.134 MB / 0.8719 GB, free: 13.39 MB / 0.5573 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 2 * Number of states: 34 (infiniteBus.gENCLS.delta,infiniteBus.gENCLS.omega,infiniteBus.gENCLS.eq,genunit.gENROE.w,genunit.gENROE.delta,genunit.gENROE.Epd,genunit.gENROE.Epq,genunit.gENROE.PSIkd,genunit.gENROE.PSIkq,genunit.iEEEG1_1.imLeadLag.TF.x_scaled[1],genunit.iEEEG1_1.imSimpleLag.state,genunit.iEEEG1_1.imSimpleLag1.state,genunit.iEEEG1_1.imSimpleLag2.state,genunit.iEEEG1_1.imSimpleLag3.state,genunit.iEEEG1_1.limIntegrator.y,genunit.eSST1A1.imDerivativeLag.x,genunit.eSST1A1.imLeadLag.TF.x_scaled[1],genunit.eSST1A1.imLeadLag1.TF.x_scaled[1],genunit.eSST1A1.simpleLagLim.state,genunit.eSST1A1.TransducerDelay.state,genunit.pSS2A.Leadlag1.TF.x_scaled[1],genunit.pSS2A.Leadlag2.TF.x_scaled[1],genunit.pSS2A.SimpleLag1.state,genunit.pSS2A.SimpleLag2.state,genunit.pSS2A.rampTrackingFilter.TF1[1].x_scaled[1],genunit.pSS2A.rampTrackingFilter.TF1[2].x_scaled[1],genunit.pSS2A.rampTrackingFilter.TF1[3].x_scaled[1],genunit.pSS2A.rampTrackingFilter.TF1[4].x_scaled[1],genunit.pSS2A.rampTrackingFilter.TF1[5].x_scaled[1],genunit.pSS2A.rampTrackingFilter.TF2[1].x_scaled[1],genunit.pSS2A.derivativeLag.TF.x_scaled[1],genunit.pSS2A.derivativeLag1.TF.x_scaled[1],genunit.pSS2A.derivativeLag2.TF.x_scaled[1],genunit.pSS2A.derivativeLag3.TF.x_scaled[1]) * Number of discrete variables: 2 ($whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (169): * Single equations (assignments): 167 * Array equations: 0 * Algorithm blocks: 0 * 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: 0 * Non-linear torn systems: 2 {1 9,22 23} Notification: Performance of Backend phase and start with SimCode phase: time 0.0005889/1.95, allocations: 274.1 kB / 0.8721 GB, free: 13.11 MB / 0.5573 GB Notification: Performance of simCode: created initialization part: time 0.02369/1.974, allocations: 7.637 MB / 0.8796 GB, free: 5.469 MB / 0.5573 GB Notification: Performance of simCode: created event and clocks part: time 8.616e-06/1.974, allocations: 3.938 kB / 0.8796 GB, free: 5.465 MB / 0.5573 GB Notification: Performance of simCode: created simulation system equations: time 0.007287/1.981, allocations: 2.514 MB / 0.882 GB, free: 2.93 MB / 0.5573 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002746/1.984, allocations: 296.4 kB / 0.8823 GB, free: 2.641 MB / 0.5573 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2347/2.219, allocations: 5.657 MB / 0.8878 GB, free: 182.8 MB / 0.5573 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002482/2.221, allocations: 2.36 MB / 0.8901 GB, free: 182 MB / 0.5573 GB Notification: Performance of SimCode: time 9.22e-07/2.221, allocations: 0 / 0.8901 GB, free: 182 MB / 0.5573 GB (rm -f OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator --tempDir=temp_OpenIPSL_dev_OpenIPSL_Examples_Tutorial_Example_4_Experiments_SMIBVarLoad_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=1e-06 OpenIPSL_dev_OpenIPSL_Examples_Tutorial_Example_4_Experiments_SMIBVarLoad.fmu > OpenIPSL_dev_OpenIPSL.Examples.Tutorial.Example_4.Experiments.SMIBVarLoad.pipe 2>&1)