Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001016/0.001016, allocations: 84.73 kB / 21.5 MB, free: 2.988 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001199/0.001199, allocations: 163.5 kB / 24.91 MB, free: 8.258 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 0.9716/0.9716, allocations: 177 MB / 205.2 MB, free: 5.457 MB / 186.7 MB " [Timeout remaining time 179] Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo) Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo) Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo) Running command: translateModel(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="time|Itr|Iqs|loadInertiaM.phi|loadInertiaM.w|loadInertiaMQS.phi|loadInertiaMQS.w|smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.re|smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.im|smpm.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.re|smpm.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.im",fileNamePrefix="Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains") translateModel(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="time|Itr|Iqs|loadInertiaM.phi|loadInertiaM.w|loadInertiaMQS.phi|loadInertiaMQS.w|smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.re|smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.im|smpm.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.re|smpm.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter.[0-9,]+..Phi.im",fileNamePrefix="Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.182e-06/1.182e-06, allocations: 0 / 273.5 MB, free: 1.137 MB / 250.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 1.191e-05/1.309e-05, allocations: 2.312 kB / 273.5 MB, free: 1.133 MB / 250.7 MB Notification: Performance of NFInst.instantiate(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains): time 0.1457/0.1457, allocations: 35.73 MB / 309.2 MB, free: 9.965 MB / 266.7 MB Notification: Performance of NFInst.instExpressions: time 0.02172/0.1674, allocations: 10.73 MB / 319.9 MB, free: 2.109 MB / 266.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.007311/0.1747, allocations: 332.4 kB / 320.2 MB, free: 1.996 MB / 266.7 MB Notification: Performance of NFTyping.typeComponents: time 0.01342/0.1881, allocations: 9.622 MB / 329.9 MB, free: 9.707 MB / 282.7 MB Notification: Performance of NFTyping.typeBindings: time 0.01212/0.2002, allocations: 4.129 MB / 334 MB, free: 5.555 MB / 282.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.005908/0.2061, allocations: 2.45 MB / 336.4 MB, free: 3.109 MB / 282.7 MB Notification: Performance of NFFlatten.flatten: time 0.01639/0.2225, allocations: 14.89 MB / 351.3 MB, free: 4.172 MB / 298.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.02517/0.2477, allocations: 17.36 MB / 368.7 MB, free: 2.609 MB / 314.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.01885/0.2665, allocations: 11 MB / 379.7 MB, free: 7.594 MB / 330.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0112/0.2777, allocations: 7.77 MB / 387.5 MB, free: 15.81 MB / 346.7 MB Notification: Performance of NFPackage.collectConstants: time 0.004668/0.2824, allocations: 2.02 MB / 389.5 MB, free: 13.79 MB / 346.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.006296/0.2887, allocations: 2.456 MB / 391.9 MB, free: 11.33 MB / 346.7 MB Notification: Performance of NFScalarize.scalarize: time 0.004347/0.2931, allocations: 4.184 MB / 396.1 MB, free: 7.137 MB / 346.7 MB Notification: Performance of NFVerifyModel.verify: time 0.008686/0.3017, allocations: 5.318 MB / 401.4 MB, free: 1.809 MB / 346.7 MB Notification: Performance of NFConvertDAE.convert: time 0.01726/0.319, allocations: 12.9 MB / 414.3 MB, free: 4.871 MB / 362.7 MB Notification: Performance of FrontEnd - DAE generated: time 7.003e-06/0.319, allocations: 0 / 414.3 MB, free: 4.871 MB / 362.7 MB Notification: Performance of FrontEnd: time 1.673e-06/0.319, allocations: 0 / 414.3 MB, free: 4.871 MB / 362.7 MB Notification: Performance of Transformations before backend: time 0.0005604/0.3196, allocations: 0 / 414.3 MB, free: 4.871 MB / 362.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 3330 * Number of variables: 3330 Notification: Performance of Generate backend data structure: time 0.02655/0.3461, allocations: 15.21 MB / 429.5 MB, free: 5.547 MB / 378.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.087e-05/0.3462, allocations: 11.98 kB / 429.6 MB, free: 5.535 MB / 378.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.2786/0.6248, allocations: 6.885 MB / 436.4 MB, free: 79.39 MB / 378.8 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01025/0.635, allocations: 4.647 MB / 441.1 MB, free: 79.04 MB / 378.8 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006181/0.6357, allocations: 0.9071 MB / 442 MB, free: 79.01 MB / 378.8 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002684/0.6383, allocations: 1.197 MB / 443.2 MB, free: 79 MB / 378.8 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01548/0.6538, allocations: 9.691 MB / 452.9 MB, free: 78.03 MB / 378.8 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002776/0.6541, allocations: 19.89 kB / 452.9 MB, free: 78.02 MB / 378.8 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001027/0.6551, allocations: 0.4926 MB / 453.4 MB, free: 78.02 MB / 378.8 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004787/0.6556, allocations: 0.6569 MB / 454.1 MB, free: 78 MB / 378.8 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008226/0.6638, allocations: 4.62 MB / 458.7 MB, free: 77.69 MB / 378.8 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.04391/0.7077, allocations: 37.51 MB / 496.2 MB, free: 46.43 MB / 378.8 MB Notification: Performance of preOpt comSubExp (simulation): time 0.006957/0.7147, allocations: 6.604 MB / 0.491 GB, free: 39.99 MB / 378.8 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.00131/0.716, allocations: 1.4 MB / 0.4924 GB, free: 38.64 MB / 378.8 MB Notification: Performance of preOpt evalFunc (simulation): time 0.006565/0.7226, allocations: 5.022 MB / 0.4973 GB, free: 33.93 MB / 378.8 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.653e-05/0.7226, allocations: 81.27 kB / 0.4974 GB, free: 33.85 MB / 378.8 MB Notification: Performance of pre-optimization done (n=402): time 4.949e-06/0.7226, allocations: 0 / 0.4974 GB, free: 33.85 MB / 378.8 MB Notification: Performance of matching and sorting (n=412): time 0.01343/0.7361, allocations: 8.678 MB / 0.5058 GB, free: 25.6 MB / 378.8 MB Notification: Performance of inlineWhenForInitialization (initialization): time 3.278e-05/0.7361, allocations: 120.4 kB / 0.5059 GB, free: 25.46 MB / 378.8 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002039/0.7381, allocations: 3.363 MB / 0.5092 GB, free: 22.76 MB / 378.8 MB Notification: Performance of collectPreVariables (initialization): time 0.0001621/0.7383, allocations: 93.7 kB / 0.5093 GB, free: 22.66 MB / 378.8 MB Notification: Performance of collectInitialEqns (initialization): time 0.001051/0.7393, allocations: 4.96 MB / 0.5142 GB, free: 17.88 MB / 378.8 MB Notification: Performance of collectInitialBindings (initialization): time 0.0004818/0.7398, allocations: 1.485 MB / 0.5156 GB, free: 16.48 MB / 378.8 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.000951/0.7408, allocations: 1.17 MB / 0.5168 GB, free: 15.43 MB / 378.8 MB Notification: Performance of setup shared object (initialization): time 1.956e-05/0.7408, allocations: 301.1 kB / 0.517 GB, free: 15.13 MB / 378.8 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008919/0.7417, allocations: 0.819 MB / 0.5178 GB, free: 14.3 MB / 378.8 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001317/0.743, allocations: 3.198 MB / 0.521 GB, free: 10.14 MB / 378.8 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.002772/0.7458, allocations: 4.66 MB / 0.5255 GB, free: 4.797 MB / 378.8 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.265e-05/0.7458, allocations: 24 kB / 0.5255 GB, free: 4.773 MB / 378.8 MB Notification: Performance of matching and sorting (n=828) (initialization): time 0.004514/0.7503, allocations: 4.375 MB / 0.5298 GB, free: 0.9219 MB / 378.8 MB Notification: Performance of prepare postOptimizeDAE: time 3.468e-05/0.7503, allocations: 40 kB / 0.5298 GB, free: 0.8828 MB / 378.8 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.101e-05/0.7504, allocations: 80 kB / 0.5299 GB, free: 0.8047 MB / 378.8 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.001582/0.752, allocations: 0.9477 MB / 0.5308 GB, free: 15.86 MB / 394.8 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002721/0.7547, allocations: 1.452 MB / 0.5323 GB, free: 14.51 MB / 394.8 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007967/0.7627, allocations: 8.167 MB / 0.5402 GB, free: 6.172 MB / 394.8 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002909/0.7656, allocations: 247.9 kB / 0.5405 GB, free: 5.93 MB / 394.8 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004159/0.766, allocations: 269.6 kB / 0.5407 GB, free: 5.668 MB / 394.8 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 373 * 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 (764): * Single equations (assignments): 758 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 1 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 4 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 1 system {(2,100.0%)} * 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): 4 systems {(1,1,100.0%), (1,5,100.0%), (1,1,100.0%), (10,46,50.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.002245/0.7682, allocations: 0.5366 MB / 0.5413 GB, free: 5.223 MB / 394.8 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008162/0.769, allocations: 439.5 kB / 0.5417 GB, free: 4.793 MB / 394.8 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005287/0.7743, allocations: 2.999 MB / 0.5446 GB, free: 1.801 MB / 394.8 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.002467/0.7768, allocations: 1.387 MB / 0.546 GB, free: 428 kB / 394.8 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.863e-05/0.7768, allocations: 12 kB / 0.546 GB, free: 416 kB / 394.8 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.143e-05/0.7768, allocations: 19.92 kB / 0.546 GB, free: 396 kB / 394.8 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0135/0.7903, allocations: 8.721 MB / 0.5545 GB, free: 8.922 MB / 410.8 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.285e-05/0.7904, allocations: 4.594 kB / 0.5545 GB, free: 8.918 MB / 410.8 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002102/0.7925, allocations: 0.6526 MB / 0.5552 GB, free: 8.297 MB / 410.8 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.002478/0.7949, allocations: 0.9735 MB / 0.5561 GB, free: 7.332 MB / 410.8 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002366/0.7952, allocations: 95.95 kB / 0.5562 GB, free: 7.238 MB / 410.8 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01034/0.8055, allocations: 11.57 MB / 0.5675 GB, free: 11.35 MB / 426.8 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.051e-06/0.8055, allocations: 8 kB / 0.5675 GB, free: 11.34 MB / 426.8 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00621/0.8117, allocations: 3.802 MB / 0.5712 GB, free: 7.531 MB / 426.8 MB Notification: Performance of postOpt removeConstants (simulation): time 0.001438/0.8132, allocations: 0.592 MB / 0.5718 GB, free: 6.938 MB / 426.8 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005029/0.8137, allocations: 84 kB / 0.5719 GB, free: 6.855 MB / 426.8 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001369/0.815, allocations: 120 kB / 0.572 GB, free: 6.738 MB / 426.8 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005536/0.8156, allocations: 312.9 kB / 0.5723 GB, free: 6.438 MB / 426.8 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002296/0.8158, allocations: 91.95 kB / 0.5724 GB, free: 6.348 MB / 426.8 MB Notification: Performance of sorting global known variables: time 0.001725/0.8175, allocations: 1.613 MB / 0.574 GB, free: 4.934 MB / 426.8 MB Notification: Performance of sort global known variables: time 1.8e-07/0.8175, allocations: 0 / 0.574 GB, free: 4.934 MB / 426.8 MB Notification: Performance of remove unused functions: time 0.004386/0.8219, allocations: 1.961 MB / 0.5759 GB, free: 2.969 MB / 426.8 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 21 * Number of states: 10 (smpmQS.inertiaRotor.w,smpmQS.rotorCage.port_p.reference.gamma,loadInertiaMQS.phi,smpm.inertiaRotor.w,smpm.stator.zeroInductor.i0,smpm.stator.core.Phi.re,smpm.stator.core.Phi.im,smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[2].Phi.re,smpm.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[2].Phi.im,loadInertiaM.phi) * 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 (353): * Single equations (assignments): 346 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 1 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 6 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 6 systems {(1,1,100.0%), (10,46,52.0%), (1,1,100.0%), (1,5,100.0%), (1,8,100.0%), (2,13,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.0004099/0.8223, allocations: 274.7 kB / 0.5761 GB, free: 2.734 MB / 426.8 MB Notification: Performance of simCode: created initialization part: time 0.1109/0.9332, allocations: 3.757 MB / 0.5798 GB, free: 113.3 MB / 426.8 MB Notification: Performance of simCode: created event and clocks part: time 0.0002213/0.9335, allocations: 76.69 kB / 0.5799 GB, free: 113.3 MB / 426.8 MB Notification: Performance of simCode: created simulation system equations: time 0.003051/0.9365, allocations: 2.356 MB / 0.5822 GB, free: 112.6 MB / 426.8 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003538/0.94, allocations: 1.303 MB / 0.5834 GB, free: 112.5 MB / 426.8 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01864/0.9587, allocations: 17.17 MB / 0.6002 GB, free: 105.9 MB / 426.8 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001781/0.9605, allocations: 2.281 MB / 0.6024 GB, free: 105.6 MB / 426.8 MB Notification: Performance of simCode: alias equations: time 0.002132/0.9626, allocations: 0.8159 MB / 0.6032 GB, free: 105.5 MB / 426.8 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001913/0.9645, allocations: 1.18 MB / 0.6044 GB, free: 105.4 MB / 426.8 MB Notification: Performance of SimCode: time 1.473e-06/0.9645, allocations: 0 / 0.6044 GB, free: 105.4 MB / 426.8 MB Notification: Performance of Templates: time 0.09126/1.056, allocations: 80.54 MB / 0.683 GB, free: 37.61 MB / 426.8 MB " [Timeout remaining time 659] make -j1 -f Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.makefile [Timeout 660] (rm -f Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.pipe ; mkfifo Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.pipe >> ../files/Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.sim & ./Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains -abortSlowSimulation -alarm=240 -s gbode -gbm=radauIIA3 -emit_protected -lv LOG_STATS > Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains.pipe 2>&1) [Timeout 240] diffSimulationResults("Modelica_trunk_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.SynchronousMachines.SMPM_Mains_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/Modelica/Magnetic/QuasiStatic/FundamentalWave/Examples/BasicMachines/SynchronousMachines/SMPM_Mains/SMPM_Mains.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660] "" [Timeout remaining time 660] Reference file matches [Calling sys.exit(0), Time elapsed: 5.353386643342674]