Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.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.001623/0.001623, allocations: 114.3 kB / 21.18 MB, free: 0.6289 MB / 14.72 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.001996/0.001996, allocations: 210.9 kB / 24.48 MB, free: 4.035 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo): time 1.416/1.416, allocations: 230.4 MB / 258.1 MB, free: 8.137 MB / 206.1 MB " [Timeout remaining time 178] Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/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.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=6000,variableFilter="time|dcpm.ia|dcpm.tauElectrical|dcee.ia|dcee.tauElectrical|dcse.ia|dcse.tauElectrical|loadInertia1.phi|loadInertia1.w|loadInertia2.phi|loadInertia2.w|loadInertia3.phi|loadInertia3.w",fileNamePrefix="Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics") translateModel(Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=6000,variableFilter="time|dcpm.ia|dcpm.tauElectrical|dcee.ia|dcee.tauElectrical|dcse.ia|dcse.tauElectrical|loadInertia1.phi|loadInertia1.w|loadInertia2.phi|loadInertia2.w|loadInertia3.phi|loadInertia3.w",fileNamePrefix="Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics") [Timeout 660] "Warning: Requested package Modelica of version trunk, but this package was already loaded with version 4.1.0. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions. Warning: Requested package Complex of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions. Warning: Requested package ModelicaServices of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions. Notification: Performance of FrontEnd - loaded program: time 0.002091/0.002091, allocations: 63.83 kB / 378.7 MB, free: 2.863 MB / 302.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.222/0.2241, allocations: 53.32 MB / 432.1 MB, free: 7.371 MB / 334.1 MB Notification: Performance of NFInst.instantiate(Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics): time 0.02167/0.2458, allocations: 18.96 MB / 451 MB, free: 4.332 MB / 350.1 MB Notification: Performance of NFInst.instExpressions: time 0.009927/0.2557, allocations: 5.737 MB / 456.8 MB, free: 14.57 MB / 366.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001772/0.2575, allocations: 59.88 kB / 456.8 MB, free: 14.52 MB / 366.1 MB Notification: Performance of NFTyping.typeComponents: time 0.003153/0.2607, allocations: 1.367 MB / 458.2 MB, free: 13.14 MB / 366.1 MB Notification: Performance of NFTyping.typeBindings: time 0.003071/0.2637, allocations: 1.299 MB / 459.5 MB, free: 11.83 MB / 366.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00137/0.2651, allocations: 0.6851 MB / 460.2 MB, free: 11.15 MB / 366.1 MB Notification: Performance of NFFlatten.flatten: time 0.004483/0.2696, allocations: 3.93 MB / 464.1 MB, free: 7.207 MB / 366.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001609/0.2712, allocations: 1.081 MB / 465.2 MB, free: 6.07 MB / 366.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.001868/0.2731, allocations: 1.475 MB / 466.7 MB, free: 4.59 MB / 366.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.001933/0.275, allocations: 1.583 MB / 468.2 MB, free: 3 MB / 366.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0004669/0.2755, allocations: 372 kB / 468.6 MB, free: 2.637 MB / 366.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.000731/0.2762, allocations: 411.9 kB / 469 MB, free: 2.234 MB / 366.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0006131/0.2768, allocations: 0.7356 MB / 469.7 MB, free: 1.496 MB / 366.1 MB Notification: Performance of NFVerifyModel.verify: time 0.001797/0.2786, allocations: 1.761 MB / 471.5 MB, free: 15.72 MB / 382.1 MB Notification: Performance of NFConvertDAE.convert: time 0.005742/0.2843, allocations: 4.622 MB / 476.1 MB, free: 11.09 MB / 382.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.63e-06/0.2843, allocations: 3.938 kB / 476.1 MB, free: 11.08 MB / 382.1 MB Notification: Performance of FrontEnd: time 1.783e-06/0.2843, allocations: 0 / 476.1 MB, free: 11.08 MB / 382.1 MB Notification: Performance of Transformations before backend: time 0.0001163/0.2845, allocations: 0 / 476.1 MB, free: 11.08 MB / 382.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 666 * Number of variables: 666 Notification: Performance of Generate backend data structure: time 0.006797/0.2913, allocations: 3.426 MB / 479.6 MB, free: 7.586 MB / 382.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.062e-05/0.2913, allocations: 8.031 kB / 479.6 MB, free: 7.578 MB / 382.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001649/0.293, allocations: 497.6 kB / 480 MB, free: 7.09 MB / 382.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004017/0.297, allocations: 1.752 MB / 481.8 MB, free: 5.285 MB / 382.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001747/0.2971, allocations: 193.2 kB / 482 MB, free: 5.094 MB / 382.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004358/0.2976, allocations: 271.8 kB / 482.3 MB, free: 4.828 MB / 382.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.004855/0.3024, allocations: 2.47 MB / 484.7 MB, free: 2.23 MB / 382.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 7.962e-05/0.3025, allocations: 15.94 kB / 484.7 MB, free: 2.215 MB / 382.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002566/0.3028, allocations: 108 kB / 484.8 MB, free: 2.109 MB / 382.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.596e-05/0.3028, allocations: 64 kB / 484.9 MB, free: 2.047 MB / 382.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00329/0.3061, allocations: 1.642 MB / 486.6 MB, free: 400 kB / 382.1 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01456/0.3207, allocations: 10.59 MB / 497.1 MB, free: 5.238 MB / 398.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.001437/0.3221, allocations: 1.011 MB / 498.2 MB, free: 4.129 MB / 398.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0006157/0.3227, allocations: 319.4 kB / 498.5 MB, free: 3.816 MB / 398.1 MB Notification: Performance of preOpt evalFunc (simulation): time 4.431e-05/0.3228, allocations: 8.656 kB / 498.5 MB, free: 3.809 MB / 398.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.965e-05/0.3228, allocations: 43.22 kB / 498.5 MB, free: 3.758 MB / 398.1 MB Notification: Performance of pre-optimization done (n=81): time 2.956e-06/0.3228, allocations: 0 / 498.5 MB, free: 3.758 MB / 398.1 MB Notification: Performance of matching and sorting (n=90): time 0.005493/0.3283, allocations: 2.962 MB / 0.4897 GB, free: 0.6719 MB / 398.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001133/0.3284, allocations: 175.1 kB / 0.4899 GB, free: 472 kB / 398.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003135/0.3316, allocations: 2.202 MB / 0.492 GB, free: 14.24 MB / 414.1 MB Notification: Performance of collectPreVariables (initialization): time 5.447e-05/0.3316, allocations: 41.7 kB / 0.4921 GB, free: 14.19 MB / 414.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.001246/0.3329, allocations: 1.506 MB / 0.4936 GB, free: 12.67 MB / 414.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0002751/0.3331, allocations: 357 kB / 0.4939 GB, free: 12.32 MB / 414.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004207/0.3336, allocations: 331.3 kB / 0.4942 GB, free: 11.99 MB / 414.1 MB Notification: Performance of setup shared object (initialization): time 0.0001259/0.3337, allocations: 301.1 kB / 0.4945 GB, free: 11.69 MB / 414.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007202/0.3344, allocations: 372.7 kB / 0.4949 GB, free: 11.32 MB / 414.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001451/0.3359, allocations: 1.235 MB / 0.4961 GB, free: 9.664 MB / 414.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.002272/0.3381, allocations: 1.726 MB / 0.4977 GB, free: 7.523 MB / 414.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.287e-05/0.3381, allocations: 8 kB / 0.4978 GB, free: 7.516 MB / 414.1 MB Notification: Performance of matching and sorting (n=231) (initialization): time 0.00315/0.3413, allocations: 1.84 MB / 0.4995 GB, free: 5.656 MB / 414.1 MB Notification: Performance of prepare postOptimizeDAE: time 3.303e-05/0.3413, allocations: 19.94 kB / 0.4996 GB, free: 5.637 MB / 414.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.337e-05/0.3414, allocations: 32 kB / 0.4996 GB, free: 5.605 MB / 414.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0005169/0.3419, allocations: 155.7 kB / 0.4997 GB, free: 5.441 MB / 414.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001222/0.3431, allocations: 415.2 kB / 0.5001 GB, free: 5.035 MB / 414.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004796/0.3479, allocations: 5.763 MB / 0.5058 GB, free: 14.71 MB / 430.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001429/0.3493, allocations: 95.97 kB / 0.5059 GB, free: 14.62 MB / 430.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001201/0.3494, allocations: 92 kB / 0.5059 GB, free: 14.53 MB / 430.1 MB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001373/0.3508, allocations: 0.7265 MB / 0.5067 GB, free: 13.8 MB / 430.1 MB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001408/0.3522, allocations: 1.227 MB / 0.5079 GB, free: 12.15 MB / 430.1 MB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002241/0.3545, allocations: 1.707 MB / 0.5095 GB, free: 10.04 MB / 430.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.279e-05/0.3545, allocations: 11.94 kB / 0.5095 GB, free: 10.02 MB / 430.1 MB Notification: Performance of matching and sorting (n=231) (initialization_lambda0): time 0.003197/0.3577, allocations: 1.82 MB / 0.5113 GB, free: 8.18 MB / 430.1 MB Notification: Performance of prepare postOptimizeDAE: time 2.797e-05/0.3577, allocations: 19.94 kB / 0.5113 GB, free: 8.16 MB / 430.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.821e-05/0.3577, allocations: 28 kB / 0.5114 GB, free: 8.133 MB / 430.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004762/0.3582, allocations: 160.1 kB / 0.5115 GB, free: 7.965 MB / 430.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001177/0.3594, allocations: 403.3 kB / 0.5119 GB, free: 7.57 MB / 430.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004809/0.3642, allocations: 5.766 MB / 0.5175 GB, free: 1.246 MB / 430.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00166/0.3659, allocations: 88.08 kB / 0.5176 GB, free: 1.16 MB / 430.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000126/0.366, allocations: 96 kB / 0.5177 GB, free: 1.066 MB / 430.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 134 * 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 (223): * Single equations (assignments): 219 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 4 * Mixed (continuous/discrete) equation systems: 0 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%), (1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.0003903/0.3664, allocations: 311.7 kB / 0.518 GB, free: 0.7539 MB / 430.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003691/0.3667, allocations: 234.5 kB / 0.5182 GB, free: 0.5234 MB / 430.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001886/0.3686, allocations: 0.9184 MB / 0.5191 GB, free: 15.58 MB / 446.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.051e-05/0.3686, allocations: 3.984 kB / 0.5191 GB, free: 15.58 MB / 446.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.885e-06/0.3686, allocations: 4 kB / 0.5191 GB, free: 15.57 MB / 446.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0007275/0.3694, allocations: 387.3 kB / 0.5195 GB, free: 15.18 MB / 446.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002523/0.3696, allocations: 19.98 kB / 0.5195 GB, free: 15.16 MB / 446.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008352/0.3705, allocations: 47.95 kB / 0.5196 GB, free: 15.11 MB / 446.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001123/0.3706, allocations: 64.84 kB / 0.5196 GB, free: 15.05 MB / 446.1 MB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001967/0.3725, allocations: 0.8798 MB / 0.5205 GB, free: 14.15 MB / 446.1 MB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001989/0.3745, allocations: 1.324 MB / 0.5218 GB, free: 12.81 MB / 446.1 MB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004764/0.375, allocations: 255.8 kB / 0.522 GB, free: 12.55 MB / 446.1 MB Notification: Performance of sorting global known variables: time 0.002314/0.3773, allocations: 1.458 MB / 0.5234 GB, free: 11.09 MB / 446.1 MB Notification: Performance of Backend: time 4.51e-07/0.3773, allocations: 0 / 0.5234 GB, free: 11.09 MB / 446.1 MB Notification: Performance of simCode: created initialization part: time 0.004656/0.382, allocations: 2.497 MB / 0.5259 GB, free: 8.492 MB / 446.1 MB Notification: Performance of SimCode: time 0.008405/0.3904, allocations: 5.071 MB / 0.5308 GB, free: 3.371 MB / 446.1 MB Notification: Performance of Templates: time 0.2251/0.6155, allocations: 31.25 MB / 0.5613 GB, free: 111.9 MB / 462.1 MB " [Timeout remaining time 659] make -j1 -f Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.makefile [Timeout 660] (rm -f Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.pipe ; mkfifo Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.pipe ; head -c 1048576 < Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.pipe >> ../files/Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.sim & ./Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.pipe 2>&1) [Timeout 480] diffSimulationResults("Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/Modelica/Electrical/Machines/Examples/DCMachines/DC_CompareCharacteristics/DC_CompareCharacteristics.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/Modelica_4.1.0-beta.om_Modelica.Electrical.Machines.Examples.DCMachines.DC_CompareCharacteristics.diff",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.803625013213605]