Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 90]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo)
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(ModelicaTest.MultiBody.Visualizers.ColorMaps,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="time",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps")
translateModel(ModelicaTest.MultiBody.Visualizers.ColorMaps,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="time",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps") [Timeout 660]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001192/0.001192, allocations: 122.1 kB / 17.79 MB, free: 5.273 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001551/0.001551, allocations: 198 kB / 18.74 MB, free: 4.332 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.482/1.482, allocations: 227.4 MB / 247 MB, free: 10.46 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2599/0.2599, allocations: 46.13 MB / 344.3 MB, free: 11.47 MB / 286.1 MB
Warning: Requested package Modelica 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.002321/0.002321, allocations: 87.84 kB / 481.4 MB, free: 4.035 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3526/0.3549, allocations: 62.43 MB / 0.5311 GB, free: 13.6 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Visualizers.ColorMaps): time 0.01216/0.3671, allocations: 10.37 MB / 0.5412 GB, free: 5.461 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007593/0.3748, allocations: 3.074 MB / 0.5442 GB, free: 3.051 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00268/0.3775, allocations: 70.69 kB / 0.5443 GB, free: 3.035 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006103/0.3837, allocations: 2.675 MB / 0.5469 GB, free: 1.25 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00324/0.387, allocations: 1.035 MB / 0.5479 GB, free: 468 kB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.000949/0.388, allocations: 263.5 kB / 0.5481 GB, free: 204 kB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002574/0.3905, allocations: 1.521 MB / 0.5496 GB, free: 14.68 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003227/0.3938, allocations: 2.456 MB / 0.552 GB, free: 12.19 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001466/0.3953, allocations: 0.9304 MB / 0.5529 GB, free: 11.25 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004673/0.4, allocations: 3.32 MB / 0.5562 GB, free: 7.926 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005651/0.4005, allocations: 188 kB / 0.5563 GB, free: 7.742 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008508/0.4014, allocations: 267.8 kB / 0.5566 GB, free: 7.48 MB / 414.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00261/0.404, allocations: 2.923 MB / 0.5595 GB, free: 4.551 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003782/0.4078, allocations: 3.329 MB / 0.5627 GB, free: 1.195 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009999/0.4178, allocations: 9.809 MB / 0.5723 GB, free: 7.336 MB / 430.1 MB
Notification: Performance of FrontEnd - DAE generated: time 9.898e-06/0.4179, allocations: 4 kB / 0.5723 GB, free: 7.332 MB / 430.1 MB
Notification: Performance of FrontEnd: time 1.533e-06/0.4179, allocations: 3.938 kB / 0.5723 GB, free: 7.328 MB / 430.1 MB
Notification: Performance of Transformations before backend: time 0.0001746/0.4181, allocations: 0 / 0.5723 GB, free: 7.328 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: 1421
 * Number of variables: 1421
Notification: Performance of Generate backend data structure: time 0.01512/0.4332, allocations: 9.114 MB / 0.5812 GB, free: 14.1 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.705e-05/0.4333, allocations: 8.031 kB / 0.5812 GB, free: 14.09 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001592/0.4349, allocations: 1.031 MB / 0.5822 GB, free: 13.05 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006432/0.4413, allocations: 3.819 MB / 0.5859 GB, free: 9.16 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001569/0.4415, allocations: 127.3 kB / 0.5861 GB, free: 9.035 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002414/0.4417, allocations: 171.7 kB / 0.5862 GB, free: 8.871 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008805/0.4505, allocations: 6.608 MB / 0.5927 GB, free: 2.082 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.103e-05/0.4506, allocations: 7.938 kB / 0.5927 GB, free: 2.074 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001578/0.4508, allocations: 71.94 kB / 0.5928 GB, free: 2.004 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001793/0.4526, allocations: 1.557 MB / 0.5943 GB, free: 456 kB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007095/0.4597, allocations: 4.136 MB / 0.5983 GB, free: 12.31 MB / 462.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.02899/0.4887, allocations: 20.31 MB / 0.6181 GB, free: 7.734 MB / 478.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00151/0.4902, allocations: 334.2 kB / 0.6185 GB, free: 7.398 MB / 478.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001093/0.4904, allocations: 72.75 kB / 0.6185 GB, free: 7.324 MB / 478.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.004492/0.4949, allocations: 3.273 MB / 0.6217 GB, free: 3.688 MB / 478.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.227e-05/0.4949, allocations: 109.9 kB / 0.6218 GB, free: 3.57 MB / 478.1 MB
Notification: Performance of pre-optimization done (n=0): time 2.154e-06/0.495, allocations: 0 / 0.6218 GB, free: 3.57 MB / 478.1 MB
Notification: Performance of matching and sorting (n=0): time 0.000972/0.4959, allocations: 0.8786 MB / 0.6227 GB, free: 2.68 MB / 478.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.475e-05/0.496, allocations: 130.7 kB / 0.6228 GB, free: 2.539 MB / 478.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01828/0.5143, allocations: 10.55 MB / 0.6331 GB, free: 8.039 MB / 494.1 MB
Notification: Performance of collectPreVariables (initialization): time 2.021e-05/0.5144, allocations: 25.7 kB / 0.6331 GB, free: 8.008 MB / 494.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.006525/0.5209, allocations: 5.954 MB / 0.639 GB, free: 2.023 MB / 494.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001479/0.5211, allocations: 95.89 kB / 0.6391 GB, free: 1.93 MB / 494.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001016/0.5221, allocations: 0.8222 MB / 0.6399 GB, free: 1.094 MB / 494.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001431/0.5223, allocations: 305.1 kB / 0.6401 GB, free: 0.793 MB / 494.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001125/0.5234, allocations: 0.7616 MB / 0.6409 GB, free: 24 kB / 494.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003994/0.5274, allocations: 4.007 MB / 0.6448 GB, free: 10.33 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006127/0.5335, allocations: 5.197 MB / 0.6499 GB, free: 3.48 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.864e-05/0.5336, allocations: 40 kB / 0.6499 GB, free: 3.441 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=537) (initialization): time 0.008398/0.542, allocations: 4.96 MB / 0.6548 GB, free: 14.47 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 7.758e-05/0.5421, allocations: 58.34 kB / 0.6548 GB, free: 14.41 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001226/0.5423, allocations: 116.9 kB / 0.6549 GB, free: 14.3 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001616/0.5424, allocations: 152 kB / 0.6551 GB, free: 14.15 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002406/0.5448, allocations: 0.9902 MB / 0.656 GB, free: 13.16 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001895/0.545, allocations: 227.1 kB / 0.6563 GB, free: 12.94 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00335/0.5484, allocations: 0.6165 MB / 0.6569 GB, free: 12.32 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000297/0.5487, allocations: 284 kB / 0.6571 GB, free: 12.04 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 537
 * Number of states: 0 ()
 * Number of discrete variables: 30 (translate7.color[3],translate7.color[2],translate7.color[1],translate6.color[3],translate6.color[2],translate6.color[1],translate5.color[3],translate5.color[2],translate5.color[1],translate4.color[3],translate4.color[2],translate4.color[1],translate3.color[3],translate3.color[2],translate3.color[1],translate2.color[3],translate2.color[2],translate2.color[1],world.groundColor[3],world.groundColor[2],world.groundColor[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (537):
 * Single equations (assignments): 537
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.005238/0.554, allocations: 3.421 MB / 0.6605 GB, free: 8.605 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0013/0.5553, allocations: 0.9638 MB / 0.6614 GB, free: 7.629 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001705/0.557, allocations: 1.019 MB / 0.6624 GB, free: 6.602 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.601e-05/0.5571, allocations: 184.2 kB / 0.6626 GB, free: 6.414 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.423e-05/0.5572, allocations: 180.3 kB / 0.6628 GB, free: 6.23 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.57e-05/0.5572, allocations: 180.2 kB / 0.6629 GB, free: 6.047 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.008026/0.5653, allocations: 5.131 MB / 0.6679 GB, free: 0.8477 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.188e-05/0.5654, allocations: 113 kB / 0.668 GB, free: 0.7305 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 5.49e-05/0.5654, allocations: 108.9 kB / 0.6681 GB, free: 0.6172 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.483e-05/0.5655, allocations: 176.3 kB / 0.6683 GB, free: 448 kB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.43e-05/0.5656, allocations: 180.3 kB / 0.6685 GB, free: 260 kB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.083e-05/0.5657, allocations: 184.2 kB / 0.6687 GB, free: 68 kB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.279e-05/0.5658, allocations: 176.3 kB / 0.6688 GB, free: 15.89 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001439/0.5673, allocations: 1.203 MB / 0.67 GB, free: 14.65 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001486/0.5687, allocations: 0.9492 MB / 0.6709 GB, free: 13.67 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00048/0.5692, allocations: 176.3 kB / 0.6711 GB, free: 13.49 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007492/0.57, allocations: 101 kB / 0.6712 GB, free: 13.39 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.614e-05/0.5701, allocations: 188.2 kB / 0.6714 GB, free: 13.2 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.784e-05/0.5701, allocations: 108.9 kB / 0.6715 GB, free: 13.08 MB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.01171/0.5819, allocations: 7.146 MB / 0.6785 GB, free: 5.988 MB / 0.5294 GB
Notification: Performance of sort global known variables: time 9.52e-07/0.5819, allocations: 4 kB / 0.6785 GB, free: 5.984 MB / 0.5294 GB
Notification: Performance of remove unused functions: time 0.004038/0.5859, allocations: 1.137 MB / 0.6796 GB, free: 4.844 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * 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 simulation (0):
 * Single equations (assignments): 0
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0001838/0.5861, allocations: 170.5 kB / 0.6797 GB, free: 4.664 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.003128/0.5893, allocations: 1.871 MB / 0.6816 GB, free: 2.82 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 3.847e-06/0.5893, allocations: 0 / 0.6816 GB, free: 2.82 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 6.813e-06/0.5893, allocations: 4 kB / 0.6816 GB, free: 2.816 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01356/0.6029, allocations: 3.448 MB / 0.6849 GB, free: 15.36 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02526/0.6282, allocations: 15.93 MB / 0.7005 GB, free: 15.37 MB / 0.5606 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006045/0.6342, allocations: 5.274 MB / 0.7056 GB, free: 10.05 MB / 0.5606 GB
Notification: Performance of simCode: alias equations: time 0.005532/0.6398, allocations: 2.098 MB / 0.7077 GB, free: 7.945 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006564/0.6405, allocations: 403.4 kB / 0.7081 GB, free: 7.555 MB / 0.5606 GB
Notification: Performance of SimCode: time 4.017e-06/0.6405, allocations: 7.938 kB / 0.7081 GB, free: 7.547 MB / 0.5606 GB
Notification: Performance of Templates: time 0.6409/1.281, allocations: 83.19 MB / 0.7893 GB, free: 95.27 MB / 0.5607 GB
make -j1 -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.sim & ./ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/MultiBody/Visualizers/ColorMaps/ColorMaps.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Visualizers.ColorMaps.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
Reference file matches