Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.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/HanserModelica 2.0.0-master/package.mo", uses=false)
Using package HanserModelica with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/HanserModelica 2.0.0-master/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)
Ignoring simflag  -noemit -jacobian= since it seems broken on HelloWorld
Running command: translateModel(HanserModelica.InductionMachines.IMC_Transformer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=50000,variableFilter="",fileNamePrefix="HanserModelica_HanserModelica.InductionMachines.IMC_Transformer")
translateModel(HanserModelica.InductionMachines.IMC_Transformer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=50000,variableFilter="",fileNamePrefix="HanserModelica_HanserModelica.InductionMachines.IMC_Transformer")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001129/0.001129, allocations: 113.5 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.402/1.402, allocations: 222.9 MB / 240 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.00138/0.00138, allocations: 192.5 kB / 290.3 MB, free: 2.23 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/HanserModelica 2.0.0-master/package.mo): time 0.03409/0.03409, allocations: 8.797 MB / 349.3 MB, free: 4.605 MB / 238.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00319/0.00319, allocations: 78.89 kB / 416 MB, free: 39.98 MB / 286.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1348/0.1381, allocations: 51.57 MB / 467.6 MB, free: 10.15 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(HanserModelica.InductionMachines.IMC_Transformer): time 0.05001/0.1881, allocations: 49.49 MB / 0.505 GB, free: 8.434 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03285/0.221, allocations: 12.89 MB / 0.5176 GB, free: 11.5 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01165/0.2327, allocations: 378.8 kB / 0.5179 GB, free: 11.13 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.3262/0.5589, allocations: 13.79 MB / 0.5314 GB, free: 6.582 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02586/0.5848, allocations: 5.429 MB / 0.5367 GB, free: 6.574 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01288/0.5977, allocations: 3.257 MB / 0.5399 GB, free: 6.5 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.04469/0.6424, allocations: 24.21 MB / 0.5635 GB, free: 6.141 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.09818/0.7406, allocations: 46.98 MB / 0.6094 GB, free: 3.012 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.03492/0.7756, allocations: 12.6 MB / 0.6217 GB, free: 6.719 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0307/0.8063, allocations: 13.83 MB / 0.6352 GB, free: 9.312 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.01396/0.8203, allocations: 3.625 MB / 0.6387 GB, free: 5.688 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01937/0.8397, allocations: 4.109 MB / 0.6428 GB, free: 1.598 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.01531/0.8551, allocations: 7.29 MB / 0.6499 GB, free: 10.41 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.04104/0.8962, allocations: 13.78 MB / 0.6633 GB, free: 12.67 MB / 462.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.5523/1.448, allocations: 48.67 MB / 0.7109 GB, free: 77.88 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.853e-06/1.449, allocations: 0 / 0.7109 GB, free: 77.88 MB / 494.1 MB
Notification: Performance of FrontEnd: time 2.305e-06/1.449, allocations: 0 / 0.7109 GB, free: 77.88 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 0.001425/1.45, allocations: 0 / 0.7109 GB, free: 77.88 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 5818
 * Number of variables: 5818
Notification: Performance of Generate backend data structure: time 0.1049/1.555, allocations: 27.61 MB / 0.7378 GB, free: 70.97 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.631e-05/1.555, allocations: 9.906 kB / 0.7378 GB, free: 70.97 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07623/1.631, allocations: 13.93 MB / 0.7514 GB, free: 67.04 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04399/1.675, allocations: 14.99 MB / 0.7661 GB, free: 61.36 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002109/1.677, allocations: 1.573 MB / 0.7676 GB, free: 60.66 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01374/1.691, allocations: 2.079 MB / 0.7696 GB, free: 59.96 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1046/1.796, allocations: 34.72 MB / 0.8035 GB, free: 25.55 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001546/1.797, allocations: 30.62 kB / 0.8036 GB, free: 25.53 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01137/1.809, allocations: 0.8595 MB / 0.8044 GB, free: 24.69 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001203/1.81, allocations: 1.149 MB / 0.8055 GB, free: 23.54 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07949/1.89, allocations: 32.33 MB / 0.8371 GB, free: 7.191 MB / 0.4982 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.4703/2.36, allocations: 106.2 MB / 0.9408 GB, free: 175.1 MB / 0.5763 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03745/2.397, allocations: 50.86 MB / 0.9905 GB, free: 140.5 MB / 0.5763 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0145/2.412, allocations: 9.769 MB / 1 GB, free: 140.4 MB / 0.5763 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04789/2.46, allocations: 22.52 MB / 1.022 GB, free: 134.7 MB / 0.5763 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001442/2.46, allocations: 134 kB / 1.022 GB, free: 134.6 MB / 0.5763 GB
Notification: Performance of pre-optimization done (n=894): time 2.276e-05/2.46, allocations: 0 / 1.022 GB, free: 134.6 MB / 0.5763 GB
Notification: Performance of matching and sorting (n=906): time 0.07724/2.537, allocations: 39.47 MB / 1.061 GB, free: 115.2 MB / 0.5763 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.495e-05/2.538, allocations: 171.3 kB / 1.061 GB, free: 115.1 MB / 0.5763 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01413/2.552, allocations: 8.351 MB / 1.069 GB, free: 107.7 MB / 0.5763 GB
Notification: Performance of collectPreVariables (initialization): time 0.002395/2.554, allocations: 173.7 kB / 1.069 GB, free: 107.5 MB / 0.5763 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006529/2.561, allocations: 8.686 MB / 1.078 GB, free: 98.77 MB / 0.5763 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005648/2.566, allocations: 3.058 MB / 1.081 GB, free: 95.73 MB / 0.5763 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.005455/2.572, allocations: 2.212 MB / 1.083 GB, free: 93.51 MB / 0.5763 GB
Notification: Performance of setup shared object (initialization): time 6.257e-05/2.572, allocations: 305.1 kB / 1.083 GB, free: 93.21 MB / 0.5763 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00952/2.581, allocations: 6.238 MB / 1.089 GB, free: 86.97 MB / 0.5763 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01202/2.593, allocations: 9.965 MB / 1.099 GB, free: 75.42 MB / 0.5763 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02221/2.616, allocations: 17.23 MB / 1.116 GB, free: 56.57 MB / 0.5763 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001373/2.616, allocations: 36 kB / 1.116 GB, free: 56.53 MB / 0.5763 GB
Notification: Performance of matching and sorting (n=1484) (initialization): time 0.04263/2.659, allocations: 20.3 MB / 1.136 GB, free: 36.12 MB / 0.5763 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002712/2.659, allocations: 52 kB / 1.136 GB, free: 36.07 MB / 0.5763 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003244/2.659, allocations: 127.9 kB / 1.136 GB, free: 35.95 MB / 0.5763 GB
Notification: Tearing is skipped for strong component 1 because system size of 204 exceeds maximum system size for tearing of linear systems (200).
To adjust the maximum system size for tearing use --maxSizeLinearTearing=<size>.
Notification: Performance of postOpt tearingSystem (initialization): time 0.003133/2.662, allocations: 0.9276 MB / 1.137 GB, free: 35 MB / 0.5763 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009878/2.672, allocations: 2.41 MB / 1.139 GB, free: 32.59 MB / 0.5763 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009572/2.682, allocations: 12.48 MB / 1.151 GB, free: 19.43 MB / 0.5763 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01056/2.692, allocations: 0.6047 MB / 1.152 GB, free: 18.82 MB / 0.5763 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003494/2.696, allocations: 0.5078 MB / 1.152 GB, free: 18.31 MB / 0.5763 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 531
 * Number of states: 0 ()
 * Number of discrete variables: 12 (booleanStep2[3].y,booleanStep2[2].y,booleanStep2[1].y,idealCloser.control[3],idealCloser.control[2],idealCloser.control[1],booleanStep2QS[3].y,booleanStep2QS[2].y,booleanStep2QS[1].y,booleanStep1QS[3].y,booleanStep1QS[2].y,booleanStep1QS[1].y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1230):
 * Single equations (assignments): 1223
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 5
 * 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%), (204,1.3%)}
 * 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): 5 systems
   {(3,25,77.8%), (1,8,100.0%), (1,1,100.0%), (1,13,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0181/2.714, allocations: 7.924 MB / 1.16 GB, free: 10.37 MB / 0.5763 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003677/2.718, allocations: 0.9068 MB / 1.161 GB, free: 9.453 MB / 0.5763 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.3307/3.048, allocations: 17.03 MB / 1.178 GB, free: 199.2 MB / 0.5763 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.758e-05/3.049, allocations: 90.78 kB / 1.178 GB, free: 199.2 MB / 0.5763 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001387/3.049, allocations: 42.31 kB / 1.178 GB, free: 199.2 MB / 0.5763 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0002563/3.049, allocations: 49.72 kB / 1.178 GB, free: 199.2 MB / 0.5763 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.07453/3.124, allocations: 35.82 MB / 1.213 GB, free: 187.3 MB / 0.5763 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.898e-05/3.124, allocations: 6.375 kB / 1.213 GB, free: 187.3 MB / 0.5763 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007/3.131, allocations: 1.425 MB / 1.214 GB, free: 187.2 MB / 0.5763 GB
Notification: Tearing is skipped for strong component 14 because system size of 204 exceeds maximum system size for tearing of linear systems (200).
To adjust the maximum system size for tearing use --maxSizeLinearTearing=<size>.
Notification: Performance of postOpt tearingSystem (simulation): time 0.003327/3.134, allocations: 0.9776 MB / 1.215 GB, free: 186.9 MB / 0.5763 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002412/3.136, allocations: 205.8 kB / 1.215 GB, free: 186.8 MB / 0.5763 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01491/3.151, allocations: 17.15 MB / 1.232 GB, free: 173.1 MB / 0.5763 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.953e-06/3.151, allocations: 7.156 kB / 1.232 GB, free: 173.1 MB / 0.5763 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04182/3.193, allocations: 24.78 MB / 1.256 GB, free: 163 MB / 0.5763 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008464/3.202, allocations: 2.237 MB / 1.258 GB, free: 161.8 MB / 0.5763 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004286/3.206, allocations: 184.4 kB / 1.259 GB, free: 161.6 MB / 0.5763 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008031/3.214, allocations: 499.7 kB / 1.259 GB, free: 161.3 MB / 0.5763 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002263/3.216, allocations: 0.7892 MB / 1.26 GB, free: 160.8 MB / 0.5763 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0007532/3.217, allocations: 251.4 kB / 1.26 GB, free: 160.6 MB / 0.5763 GB
Notification: Performance of sorting global known variables: time 0.01009/3.227, allocations: 5.693 MB / 1.266 GB, free: 155.8 MB / 0.5763 GB
Notification: Performance of sort global known variables: time 7.11e-07/3.227, allocations: 0 / 1.266 GB, free: 155.8 MB / 0.5763 GB
Notification: Performance of remove unused functions: time 0.01762/3.245, allocations: 3.471 MB / 1.269 GB, free: 152.4 MB / 0.5763 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 27
 * Number of states: 12 (imcQS.inertiaRotor.w,imcQS.rotorCage.port_p.reference.gamma,quadraticLoadTorqueQS.phi,imc.inertiaRotor.w,imc.stator.zeroInductor.i0,imc.stator.core.Phi.re,imc.stator.core.Phi.im,imc.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[3].Phi.re,imc.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[3].Phi.im,transformer.l1sigma.inductor[2].i,transformer.l1sigma.inductor[3].i,quadraticLoadTorque.phi)
 * Number of discrete variables: 12 (booleanStep1QS[1].y,booleanStep1QS[2].y,booleanStep1QS[3].y,booleanStep2QS[1].y,booleanStep2QS[2].y,booleanStep2QS[3].y,idealCloser.control[1],idealCloser.control[2],idealCloser.control[3],booleanStep2[1].y,booleanStep2[2].y,booleanStep2[3].y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (703):
 * Single equations (assignments): 695
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 1 system
   {(204,1.3%)}
 * 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): 7 systems
   {(1,1,100.0%), (1,8,100.0%), (3,25,88.9%), (1,1,100.0%), (1,13,100.0%), (1,8,100.0%), (2,12,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.002211/3.247, allocations: 473.2 kB / 1.269 GB, free: 152 MB / 0.5763 GB
Notification: Performance of simCode: created initialization part: time 0.02173/3.269, allocations: 16.14 MB / 1.285 GB, free: 136.4 MB / 0.5763 GB
Notification: Performance of simCode: created event and clocks part: time 1.146e-05/3.269, allocations: 4 kB / 1.285 GB, free: 136.4 MB / 0.5763 GB
Notification: Performance of simCode: created simulation system equations: time 0.01312/3.282, allocations: 8.76 MB / 1.294 GB, free: 127.5 MB / 0.5763 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01644/3.299, allocations: 2.56 MB / 1.296 GB, free: 125.1 MB / 0.5763 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07056/3.369, allocations: 38.1 MB / 1.334 GB, free: 86.98 MB / 0.5763 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02335/3.393, allocations: 13.11 MB / 1.346 GB, free: 73.82 MB / 0.5763 GB
Notification: Performance of simCode: alias equations: time 0.01442/3.407, allocations: 3.993 MB / 1.35 GB, free: 69.81 MB / 0.5763 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003917/3.411, allocations: 0.6634 MB / 1.351 GB, free: 69.15 MB / 0.5763 GB
Notification: Performance of SimCode: time 1.443e-06/3.411, allocations: 0 / 1.351 GB, free: 69.15 MB / 0.5763 GB
Notification: Performance of Templates: time 0.4812/3.892, allocations: 141.4 MB / 1.489 GB, free: 128.9 MB / 0.5763 GB
make -j1 -f HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.makefile
(rm -f HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.pipe ; mkfifo HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.pipe ; head -c 1048576 < HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.pipe >> ../files/HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.sim & ./HanserModelica_HanserModelica.InductionMachines.IMC_Transformer  -nls=newton -s=dassl -lv=LOG_STATS -abortSlowSimulation -alarm=480 -s cvode -lv LOG_STATS > HanserModelica_HanserModelica.InductionMachines.IMC_Transformer.pipe 2>&1)