Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.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: translateModel(OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test")
translateModel(OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00132/0.001325, allocations: 110.4 kB / 16.37 MB, free: 6.012 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.303/1.303, allocations: 222.9 MB / 240 MB, free: 4.516 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.001246/0.001246, allocations: 184.5 kB / 290.3 MB, free: 2.246 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.4365/0.4365, allocations: 78.54 MB / 419 MB, free: 3.18 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001461/0.001461, allocations: 79.88 kB / 498.9 MB, free: 5.633 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1142/0.1157, allocations: 68.18 MB / 0.5538 GB, free: 1.406 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test): time 0.2111/0.3269, allocations: 6.033 MB / 0.5597 GB, free: 36.76 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002725/0.3296, allocations: 1.785 MB / 0.5614 GB, free: 36.23 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003441/0.33, allocations: 10.81 kB / 0.5614 GB, free: 36.23 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0004094/0.3304, allocations: 209.9 kB / 0.5616 GB, free: 36.23 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001271/0.3317, allocations: 0.696 MB / 0.5623 GB, free: 36.09 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001006/0.3327, allocations: 0.5797 MB / 0.5629 GB, free: 36.02 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00105/0.3338, allocations: 1.336 MB / 0.5642 GB, free: 35.84 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003879/0.3342, allocations: 288 kB / 0.5645 GB, free: 35.79 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005163/0.3347, allocations: 0.5529 MB / 0.565 GB, free: 35.64 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005521/0.3353, allocations: 0.6979 MB / 0.5657 GB, free: 35.45 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001175/0.3354, allocations: 99 kB / 0.5658 GB, free: 35.45 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003474/0.3358, allocations: 230.8 kB / 0.566 GB, free: 35.44 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001635/0.3359, allocations: 270.5 kB / 0.5663 GB, free: 35.37 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003638/0.3363, allocations: 0.5795 MB / 0.5668 GB, free: 35.15 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.0009827/0.3373, allocations: 1.44 MB / 0.5682 GB, free: 34.8 MB / 430.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.027e-06/0.3373, allocations: 0 / 0.5682 GB, free: 34.8 MB / 430.1 MB
Notification: Performance of FrontEnd: time 1.443e-06/0.3373, allocations: 1.406 kB / 0.5682 GB, free: 34.8 MB / 430.1 MB
Notification: Performance of Transformations before backend: time 1.323e-05/0.3373, allocations: 0 / 0.5682 GB, free: 34.8 MB / 430.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 178
 * Number of variables: 178
Notification: Performance of Generate backend data structure: time 0.006886/0.3442, allocations: 2.448 MB / 0.5706 GB, free: 33.96 MB / 430.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.5e-05/0.3443, allocations: 11.31 kB / 0.5706 GB, free: 33.96 MB / 430.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004576/0.3489, allocations: 0.7665 MB / 0.5714 GB, free: 33.88 MB / 430.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001081/0.35, allocations: 0.735 MB / 0.5721 GB, free: 33.5 MB / 430.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002694/0.3502, allocations: 254.6 kB / 0.5723 GB, free: 33.31 MB / 430.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001438/0.3504, allocations: 72.25 kB / 0.5724 GB, free: 33.31 MB / 430.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001913/0.3523, allocations: 1.084 MB / 0.5735 GB, free: 33.23 MB / 430.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.92e-05/0.3523, allocations: 5.969 kB / 0.5735 GB, free: 33.23 MB / 430.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.759e-05/0.3524, allocations: 29.16 kB / 0.5735 GB, free: 33.23 MB / 430.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.69e-05/0.3525, allocations: 20.12 kB / 0.5735 GB, free: 33.23 MB / 430.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001939/0.3544, allocations: 1.029 MB / 0.5745 GB, free: 33.22 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.004116/0.3585, allocations: 3.059 MB / 0.5775 GB, free: 32.2 MB / 430.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002422/0.361, allocations: 1.562 MB / 0.579 GB, free: 31.25 MB / 430.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001169/0.3621, allocations: 0.7498 MB / 0.5798 GB, free: 30.96 MB / 430.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001076/0.3623, allocations: 24.86 kB / 0.5798 GB, free: 30.95 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.171e-05/0.3623, allocations: 47.38 kB / 0.5798 GB, free: 30.9 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=92): time 2.545e-06/0.3623, allocations: 0 / 0.5798 GB, free: 30.9 MB / 430.1 MB
Notification: Performance of matching and sorting (n=92): time 0.02741/0.3897, allocations: 7.468 MB / 0.5871 GB, free: 29.6 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.74e-05/0.3898, allocations: 61.5 kB / 0.5872 GB, free: 29.54 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001379/0.3912, allocations: 0.8403 MB / 0.588 GB, free: 29.17 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001962/0.3914, allocations: 45.02 kB / 0.5881 GB, free: 29.12 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003043/0.3917, allocations: 450 kB / 0.5885 GB, free: 28.77 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003104/0.392, allocations: 332.9 kB / 0.5888 GB, free: 28.51 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003889/0.3924, allocations: 201.5 kB / 0.589 GB, free: 28.41 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 8.335e-05/0.3925, allocations: 349.6 kB / 0.5893 GB, free: 28.09 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001413/0.394, allocations: 0.6948 MB / 0.59 GB, free: 27.83 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001484/0.3954, allocations: 0.8179 MB / 0.5908 GB, free: 27.47 MB / 430.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002856/0.3983, allocations: 1.494 MB / 0.5923 GB, free: 26.79 MB / 430.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.033e-06/0.3983, allocations: 5.969 kB / 0.5923 GB, free: 26.78 MB / 430.1 MB
Notification: Performance of matching and sorting (n=146) (initialization): time 0.01352/0.4119, allocations: 4.351 MB / 0.5965 GB, free: 25.74 MB / 430.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.771e-05/0.4119, allocations: 7.578 kB / 0.5965 GB, free: 25.74 MB / 430.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.213e-05/0.4119, allocations: 1.375 kB / 0.5965 GB, free: 25.74 MB / 430.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006379/0.4183, allocations: 1.898 MB / 0.5984 GB, free: 25.41 MB / 430.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009239/0.4193, allocations: 172.4 kB / 0.5985 GB, free: 25.39 MB / 430.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02163/0.4409, allocations: 9.969 MB / 0.6083 GB, free: 20.46 MB / 430.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001485/0.4424, allocations: 160.5 kB / 0.6084 GB, free: 20.37 MB / 430.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001893/0.4426, allocations: 43.95 kB / 0.6085 GB, free: 20.36 MB / 430.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * 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 (106):
 * Single equations (assignments): 105
 * 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
   {(25,16)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004487/0.4431, allocations: 219.5 kB / 0.6087 GB, free: 20.17 MB / 430.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002648/0.4434, allocations: 111.3 kB / 0.6088 GB, free: 20.11 MB / 430.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01199/0.4554, allocations: 4.059 MB / 0.6127 GB, free: 18.05 MB / 430.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.02e-05/0.4554, allocations: 9.688 kB / 0.6128 GB, free: 18.04 MB / 430.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.888e-06/0.4554, allocations: 4.938 kB / 0.6128 GB, free: 18.04 MB / 430.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.037e-05/0.4554, allocations: 5.297 kB / 0.6128 GB, free: 18.04 MB / 430.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01258/0.468, allocations: 5.633 MB / 0.6183 GB, free: 12.27 MB / 430.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.951e-06/0.468, allocations: 0 / 0.6183 GB, free: 12.27 MB / 430.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004774/0.4685, allocations: 95.83 kB / 0.6184 GB, free: 12.17 MB / 430.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005119/0.4736, allocations: 1.829 MB / 0.6201 GB, free: 10.34 MB / 430.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 9.279e-05/0.4738, allocations: 16.94 kB / 0.6202 GB, free: 10.32 MB / 430.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01662/0.4904, allocations: 8.631 MB / 0.6286 GB, free: 1.551 MB / 430.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.324e-06/0.4904, allocations: 4 kB / 0.6286 GB, free: 1.547 MB / 430.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0134/0.5038, allocations: 4.967 MB / 0.6334 GB, free: 12.55 MB / 446.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003624/0.5042, allocations: 195.6 kB / 0.6336 GB, free: 12.34 MB / 446.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002039/0.5044, allocations: 16 kB / 0.6336 GB, free: 12.33 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001003/0.5054, allocations: 98.8 kB / 0.6337 GB, free: 12.23 MB / 446.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005707/0.506, allocations: 204.7 kB / 0.6339 GB, free: 12.04 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.133e-05/0.5061, allocations: 20 kB / 0.634 GB, free: 12.02 MB / 446.1 MB
Notification: Performance of sorting global known variables: time 0.0007213/0.5068, allocations: 0.5667 MB / 0.6345 GB, free: 11.44 MB / 446.1 MB
Notification: Performance of sort global known variables: time 1.3e-07/0.5069, allocations: 0 / 0.6345 GB, free: 11.44 MB / 446.1 MB
Notification: Performance of remove unused functions: time 0.001271/0.5081, allocations: 435.6 kB / 0.6349 GB, free: 11.01 MB / 446.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 6 (gen.delta,gen.w,gen.e1q,tGTypeI.xg1,tGTypeI.xg2,tGTypeI.xg3)
 * 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 (55):
 * Single equations (assignments): 54
 * 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
   {(26,14)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0002556/0.5084, allocations: 135.1 kB / 0.6351 GB, free: 10.87 MB / 446.1 MB
Notification: Performance of simCode: created initialization part: time 0.00632/0.5147, allocations: 2.446 MB / 0.6374 GB, free: 8.418 MB / 446.1 MB
Notification: Performance of simCode: created event and clocks part: time 4.338e-06/0.5147, allocations: 8.062 kB / 0.6375 GB, free: 8.41 MB / 446.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.004359/0.5191, allocations: 1.565 MB / 0.639 GB, free: 6.828 MB / 446.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.000657/0.5198, allocations: 80 kB / 0.6391 GB, free: 6.746 MB / 446.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003595/0.5234, allocations: 1.98 MB / 0.641 GB, free: 4.789 MB / 446.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006067/0.524, allocations: 1.053 MB / 0.642 GB, free: 3.711 MB / 446.1 MB
Notification: Performance of simCode: alias equations: time 0.0002859/0.5243, allocations: 80.75 kB / 0.6421 GB, free: 3.629 MB / 446.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001975/0.5245, allocations: 63.42 kB / 0.6422 GB, free: 3.566 MB / 446.1 MB
Notification: Performance of SimCode: time 6.91e-07/0.5245, allocations: 4 kB / 0.6422 GB, free: 3.562 MB / 446.1 MB
Notification: Performance of Templates: time 0.03631/0.5608, allocations: 24.18 MB / 0.6658 GB, free: 11.57 MB / 478.1 MB
make -j1 -f OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.makefile
(rm -f OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.pipe ; mkfifo OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.pipe >> ../files/OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.sim & ./OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test  -abortSlowSimulation -alarm=480 -s gbode -lv LOG_STATS > OpenIPSL_OpenIPSL.Tests.Controls.PSAT.TG.TGTypeI_test.pipe 2>&1)