Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001388/0.001388, allocations: 120.1 kB / 18.49 MB, free: 4.586 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002069/0.002069, allocations: 215.1 kB / 21.45 MB, free: 1.641 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.572/1.572, allocations: 230.6 MB / 254.8 MB, free: 15.09 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo): time 0.951/0.951, allocations: 120.6 MB / 431.5 MB, free: 156 kB / 350.1 MB
"
[Timeout remaining time 178]
Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400,fileNamePrefix="ScalableTestSuite_ScalableTestSuite_Elementary_SimpleODE_ScaledExperiments_CascadedFirstOrder_N_400",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400,fileNamePrefix="ScalableTestSuite_ScalableTestSuite_Elementary_SimpleODE_ScaledExperiments_CascadedFirstOrder_N_400",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: ScalableTestSuite requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001951/0.001951, allocations: 67.88 kB / 0.6036 GB, free: 10.12 MB / 0.4982 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6791/0.6811, allocations: 85.81 MB / 0.6874 GB, free: 11.54 MB / 0.5139 GB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400): time 0.003189/0.6843, allocations: 1.214 MB / 0.6886 GB, free: 10.57 MB / 0.5139 GB
Notification: Performance of NFInst.instExpressions: time 0.0002167/0.6845, allocations: 17.5 kB / 0.6886 GB, free: 10.56 MB / 0.5139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 4.795e-05/0.6846, allocations: 4.844 kB / 0.6886 GB, free: 10.55 MB / 0.5139 GB
Notification: Performance of NFTyping.typeComponents: time 0.0001031/0.6847, allocations: 0 / 0.6886 GB, free: 10.55 MB / 0.5139 GB
Notification: Performance of NFTyping.typeBindings: time 5.059e-05/0.6847, allocations: 4.922 kB / 0.6886 GB, free: 10.55 MB / 0.5139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0001949/0.6849, allocations: 17.77 kB / 0.6886 GB, free: 10.54 MB / 0.5139 GB
Notification: Performance of NFFlatten.flatten: time 0.002186/0.6871, allocations: 1.934 MB / 0.6905 GB, free: 9.543 MB / 0.5139 GB
Notification: Performance of NFFlatten.resolveConnections: time 9.369e-05/0.6872, allocations: 13.91 kB / 0.6905 GB, free: 9.543 MB / 0.5139 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008368/0.688, allocations: 0.6605 MB / 0.6912 GB, free: 9.273 MB / 0.5139 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001183/0.6892, allocations: 0.766 MB / 0.6919 GB, free: 8.812 MB / 0.5139 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002295/0.6894, allocations: 101.3 kB / 0.692 GB, free: 8.812 MB / 0.5139 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002233/0.6897, allocations: 103.8 kB / 0.6921 GB, free: 8.809 MB / 0.5139 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005474/0.6902, allocations: 0.6375 MB / 0.6927 GB, free: 8.426 MB / 0.5139 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007567/0.691, allocations: 0.7192 MB / 0.6934 GB, free: 7.961 MB / 0.5139 GB
Notification: Performance of NFConvertDAE.convert: time 0.001216/0.6922, allocations: 1.309 MB / 0.6947 GB, free: 7.215 MB / 0.5139 GB
Notification: Performance of FrontEnd - DAE generated: time 6.071e-06/0.6922, allocations: 4 kB / 0.6947 GB, free: 7.211 MB / 0.5139 GB
Notification: Performance of FrontEnd: time 1.984e-06/0.6922, allocations: 0 / 0.6947 GB, free: 7.211 MB / 0.5139 GB
Notification: Performance of Transformations before backend: time 2.029e-05/0.6922, allocations: 1.062 kB / 0.6947 GB, free: 7.211 MB / 0.5139 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 401
 * Number of variables: 401
Notification: Performance of Generate backend data structure: time 0.006412/0.6986, allocations: 2.68 MB / 0.6973 GB, free: 5.598 MB / 0.5139 GB
Notification: Performance of prepare preOptimizeDAE: time 5.758e-05/0.6987, allocations: 10.16 kB / 0.6973 GB, free: 5.598 MB / 0.5139 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 7.255e-05/0.6987, allocations: 40.88 kB / 0.6974 GB, free: 5.594 MB / 0.5139 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002942/0.699, allocations: 239.9 kB / 0.6976 GB, free: 5.41 MB / 0.5139 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004734/0.6995, allocations: 155.9 kB / 0.6978 GB, free: 5.344 MB / 0.5139 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000921/0.7004, allocations: 0.5828 MB / 0.6983 GB, free: 4.941 MB / 0.5139 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.173e-05/0.7005, allocations: 123.2 kB / 0.6984 GB, free: 4.883 MB / 0.5139 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004451/0.701, allocations: 350.1 kB / 0.6988 GB, free: 4.699 MB / 0.5139 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002937/0.7039, allocations: 1.975 MB / 0.7007 GB, free: 3.598 MB / 0.5139 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.691e-05/0.7039, allocations: 0 / 0.7007 GB, free: 3.598 MB / 0.5139 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001741/0.7041, allocations: 61.75 kB / 0.7008 GB, free: 3.551 MB / 0.5139 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.266e-05/0.7041, allocations: 37.72 kB / 0.7008 GB, free: 3.551 MB / 0.5139 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001835/0.706, allocations: 1.178 MB / 0.702 GB, free: 3.016 MB / 0.5139 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.005649/0.7116, allocations: 3.515 MB / 0.7054 GB, free: 1.016 MB / 0.5139 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006594/0.7182, allocations: 4.294 MB / 0.7096 GB, free: 12.71 MB / 0.5295 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002241/0.7205, allocations: 1.341 MB / 0.7109 GB, free: 11.36 MB / 0.5295 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001663/0.7206, allocations: 47.08 kB / 0.7109 GB, free: 11.31 MB / 0.5295 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.07e-05/0.7207, allocations: 73.7 kB / 0.711 GB, free: 11.23 MB / 0.5295 GB
Notification: Performance of pre-optimization done (n=400): time 6.392e-06/0.7207, allocations: 0 / 0.711 GB, free: 11.23 MB / 0.5295 GB
Notification: Performance of matching and sorting (n=400): time 0.007421/0.7281, allocations: 4.51 MB / 0.7154 GB, free: 6.688 MB / 0.5295 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.146e-05/0.7282, allocations: 94.55 kB / 0.7155 GB, free: 6.582 MB / 0.5295 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0001817/0.7284, allocations: 105.8 kB / 0.7156 GB, free: 6.469 MB / 0.5295 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001774/0.7286, allocations: 85.7 kB / 0.7157 GB, free: 6.379 MB / 0.5295 GB
Notification: Performance of collectInitialEqns (initialization): time 6.391e-05/0.7286, allocations: 94.31 kB / 0.7158 GB, free: 6.281 MB / 0.5295 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001511/0.7302, allocations: 1.968 MB / 0.7177 GB, free: 4.297 MB / 0.5295 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001251/0.7314, allocations: 0.9549 MB / 0.7186 GB, free: 3.332 MB / 0.5295 GB
Notification: Performance of setup shared object (initialization): time 0.0001253/0.7315, allocations: 306 kB / 0.7189 GB, free: 3.027 MB / 0.5295 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003578/0.7351, allocations: 2.378 MB / 0.7212 GB, free: 0.6445 MB / 0.5295 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003932/0.739, allocations: 2.831 MB / 0.724 GB, free: 13.8 MB / 0.5452 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008391/0.7474, allocations: 4.892 MB / 0.7288 GB, free: 8.867 MB / 0.5452 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.451e-05/0.7475, allocations: 0 / 0.7288 GB, free: 8.867 MB / 0.5452 GB
Notification: Performance of matching and sorting (n=801) (initialization): time 0.009936/0.7574, allocations: 6.288 MB / 0.7349 GB, free: 2.535 MB / 0.5452 GB
Notification: Performance of prepare postOptimizeDAE: time 3.67e-05/0.7574, allocations: 10.03 kB / 0.7349 GB, free: 2.527 MB / 0.5452 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.758e-05/0.7574, allocations: 0 / 0.7349 GB, free: 2.527 MB / 0.5452 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.679e-05/0.7575, allocations: 24 kB / 0.735 GB, free: 2.504 MB / 0.5452 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006899/0.7644, allocations: 2.041 MB / 0.737 GB, free: 468 kB / 0.5452 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001054/0.7645, allocations: 31.94 kB / 0.737 GB, free: 436 kB / 0.5452 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002317/0.7668, allocations: 0.6099 MB / 0.7376 GB, free: 15.81 MB / 0.5608 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003184/0.7671, allocations: 176 kB / 0.7377 GB, free: 15.64 MB / 0.5608 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 2
 * 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 (801):
 * Single equations (assignments): 801
 * 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.001053/0.7682, allocations: 0.5224 MB / 0.7383 GB, free: 15.11 MB / 0.5608 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004752/0.7687, allocations: 167.1 kB / 0.7384 GB, free: 14.95 MB / 0.5608 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009064/0.7696, allocations: 322.3 kB / 0.7387 GB, free: 14.62 MB / 0.5608 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.024e-05/0.7696, allocations: 36 kB / 0.7388 GB, free: 14.58 MB / 0.5608 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.189e-05/0.7696, allocations: 4 kB / 0.7388 GB, free: 14.58 MB / 0.5608 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.596e-05/0.7696, allocations: 19.94 kB / 0.7388 GB, free: 14.56 MB / 0.5608 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002752/0.7724, allocations: 1.761 MB / 0.7405 GB, free: 12.74 MB / 0.5608 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.854e-06/0.7724, allocations: 0 / 0.7405 GB, free: 12.74 MB / 0.5608 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01016/0.7826, allocations: 2.049 MB / 0.7425 GB, free: 10.69 MB / 0.5608 GB
Notification: Performance of postOpt tearingSystem (simulation): time 3.98e-05/0.7826, allocations: 23.94 kB / 0.7425 GB, free: 10.67 MB / 0.5608 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007321/0.7833, allocations: 243.7 kB / 0.7428 GB, free: 10.43 MB / 0.5608 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.94e-05/0.7834, allocations: 19.92 kB / 0.7428 GB, free: 10.41 MB / 0.5608 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.673e-06/0.7834, allocations: 0 / 0.7428 GB, free: 10.41 MB / 0.5608 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007236/0.7906, allocations: 5.029 MB / 0.7477 GB, free: 5.316 MB / 0.5608 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004134/0.791, allocations: 247.4 kB / 0.7479 GB, free: 5.055 MB / 0.5608 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000478/0.7915, allocations: 219.8 kB / 0.7481 GB, free: 4.84 MB / 0.5608 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00162/0.7931, allocations: 267.7 kB / 0.7484 GB, free: 4.578 MB / 0.5608 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004323/0.7935, allocations: 234.8 kB / 0.7486 GB, free: 4.348 MB / 0.5608 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002321/0.7938, allocations: 115.9 kB / 0.7487 GB, free: 4.234 MB / 0.5608 GB
Notification: Performance of sorting global known variables: time 5.682e-05/0.7938, allocations: 91.2 kB / 0.7488 GB, free: 4.145 MB / 0.5608 GB
Notification: Performance of sort global known variables: time 7e-08/0.7938, allocations: 0 / 0.7488 GB, free: 4.145 MB / 0.5608 GB
Notification: Performance of remove unused functions: time 0.001759/0.7956, allocations: 0.8164 MB / 0.7496 GB, free: 3.328 MB / 0.5608 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 400 (x[1],x[2],x[3],x[4],x[5],x[6],x[7],x[8],x[9],x[10],x[11],x[12],x[13],x[14],x[15],x[16],x[17],x[18],x[19],x[20],x[21],x[22],x[23],x[24],x[25],x[26],x[27],x[28],x[29],x[30],x[31],x[32],x[33],x[34],x[35],x[36],x[37],x[38],x[39],x[40],x[41],x[42],x[43],x[44],x[45],x[46],x[47],x[48],x[49],x[50],x[51],x[52],x[53],x[54],x[55],x[56],x[57],x[58],x[59],x[60],x[61],x[62],x[63],x[64],x[65],x[66],x[67],x[68],x[69],x[70],x[71],x[72],x[73],x[74],x[75],x[76],x[77],x[78],x[79],x[80],x[81],x[82],x[83],x[84],x[85],x[86],x[87],x[88],x[89],x[90],x[91],x[92],x[93],x[94],x[95],x[96],x[97],x[98],x[99],x[100],x[101],x[102],x[103],x[104],x[105],x[106],x[107],x[108],x[109],x[110],x[111],x[112],x[113],x[114],x[115],x[116],x[117],x[118],x[119],x[120],x[121],x[122],x[123],x[124],x[125],x[126],x[127],x[128],x[129],x[130],x[131],x[132],x[133],x[134],x[135],x[136],x[137],x[138],x[139],x[140],x[141],x[142],x[143],x[144],x[145],x[146],x[147],x[148],x[149],x[150],x[151],x[152],x[153],x[154],x[155],x[156],x[157],x[158],x[159],x[160],x[161],x[162],x[163],x[164],x[165],x[166],x[167],x[168],x[169],x[170],x[171],x[172],x[173],x[174],x[175],x[176],x[177],x[178],x[179],x[180],x[181],x[182],x[183],x[184],x[185],x[186],x[187],x[188],x[189],x[190],x[191],x[192],x[193],x[194],x[195],x[196],x[197],x[198],x[199],x[200],x[201],x[202],x[203],x[204],x[205],x[206],x[207],x[208],x[209],x[210],x[211],x[212],x[213],x[214],x[215],x[216],x[217],x[218],x[219],x[220],x[221],x[222],x[223],x[224],x[225],x[226],x[227],x[228],x[229],x[230],x[231],x[232],x[233],x[234],x[235],x[236],x[237],x[238],x[239],x[240],x[241],x[242],x[243],x[244],x[245],x[246],x[247],x[248],x[249],x[250],x[251],x[252],x[253],x[254],x[255],x[256],x[257],x[258],x[259],x[260],x[261],x[262],x[263],x[264],x[265],x[266],x[267],x[268],x[269],x[270],x[271],x[272],x[273],x[274],x[275],x[276],x[277],x[278],x[279],x[280],x[281],x[282],x[283],x[284],x[285],x[286],x[287],x[288],x[289],x[290],x[291],x[292],x[293],x[294],x[295],x[296],x[297],x[298],x[299],x[300],x[301],x[302],x[303],x[304],x[305],x[306],x[307],x[308],x[309],x[310],x[311],x[312],x[313],x[314],x[315],x[316],x[317],x[318],x[319],x[320],x[321],x[322],x[323],x[324],x[325],x[326],x[327],x[328],x[329],x[330],x[331],x[332],x[333],x[334],x[335],x[336],x[337],x[338],x[339],x[340],x[341],x[342],x[343],x[344],x[345],x[346],x[347],x[348],x[349],x[350],x[351],x[352],x[353],x[354],x[355],x[356],x[357],x[358],x[359],x[360],x[361],x[362],x[363],x[364],x[365],x[366],x[367],x[368],x[369],x[370],x[371],x[372],x[373],x[374],x[375],x[376],x[377],x[378],x[379],x[380],x[381],x[382],x[383],x[384],x[385],x[386],x[387],x[388],x[389],x[390],x[391],x[392],x[393],x[394],x[395],x[396],x[397],x[398],x[399],x[400])
 * 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 (400):
 * Single equations (assignments): 400
 * 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.00768/0.8033, allocations: 5.9 MB / 0.7554 GB, free: 13.34 MB / 0.5764 GB
Notification: Performance of simCode: created initialization part: time 0.00742/0.8107, allocations: 4.469 MB / 0.7597 GB, free: 8.863 MB / 0.5764 GB
Notification: Performance of simCode: created event and clocks part: time 4.439e-06/0.8107, allocations: 0 / 0.7597 GB, free: 8.863 MB / 0.5764 GB
Notification: Performance of simCode: created simulation system equations: time 0.002723/0.8134, allocations: 1.712 MB / 0.7614 GB, free: 7.152 MB / 0.5764 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008808/0.8143, allocations: 128 kB / 0.7615 GB, free: 7.027 MB / 0.5764 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04606/0.8604, allocations: 33.13 MB / 0.7939 GB, free: 5.625 MB / 0.6077 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001441/0.8618, allocations: 1.652 MB / 0.7955 GB, free: 3.93 MB / 0.6077 GB
Notification: Performance of simCode: alias equations: time 0.0037/0.8655, allocations: 1.538 MB / 0.797 GB, free: 2.387 MB / 0.6077 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001618/0.8671, allocations: 0.7844 MB / 0.7978 GB, free: 1.602 MB / 0.6077 GB
Notification: Performance of SimCode: time 1.262e-06/0.8671, allocations: 0 / 0.7978 GB, free: 1.602 MB / 0.6077 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09326/0.9604, allocations: 49.82 MB / 0.8464 GB, free: 15.97 MB / 0.6702 GB
Notification: Performance of buildModelFMU: Generate platform static: time 31.22/32.18, allocations: 18.86 kB / 0.8464 GB, free: 15.95 MB / 0.6702 GB
"
[Timeout remaining time 268]
(rm -f ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.pipe ; mkfifo ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.pipe ; head -c 1048576 < ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.pipe >> ../files/ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400_res.mat --tempDir=temp_ScalableTestSuite_ScalableTestSuite_Elementary_SimpleODE_ScaledExperiments_CascadedFirstOrder_N_400_fmu --startTime=0 --stopTime=2 --stepSize=0.0008 --timeout=300 --tolerance=1e-06 ScalableTestSuite_ScalableTestSuite_Elementary_SimpleODE_ScaledExperiments_CascadedFirstOrder_N_400.fmu > ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.pipe 2>&1) [Timeout 315.0]
diffSimulationResults("ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ScalableTestSuite/ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ScalableTestSuite_ScalableTestSuite.Elementary.SimpleODE.ScaledExperiments.CascadedFirstOrder_N_400.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 297]
""

Variables in the reference:der(x[1]),der(x[2]),der(x[3]),der(x[400]),der(x[4]),der(x[5]),time,time,x[1],x[2],x[3],x[400],x[4],x[5]

Variables in the result:N,T,der(x[100]),der(x[101]),der(x[102]),der(x[103]),der(x[104]),der(x[105]),der(x[106]),der(x[107]),der(x[108]),der(x[109]),der(x[10]),der(x[110]),der(x[111]),der(x[112]),der(x[113]),der(x[114]),der(x[115]),der(x[116]),der(x[117]),der(x[118]),der(x[119]),der(x[11]),der(x[120]),der(x[121]),der(x[122]),der(x[123]),der(x[124]),der(x[125]),der(x[126]),der(x[127]),der(x[128]),der(x[129]),der(x[12]),der(x[130]),der(x[131]),der(x[132]),der(x[133]),der(x[134]),der(x[135]),der(x[136]),der(x[137]),der(x[138]),der(x[139]),der(x[13]),der(x[140]),der(x[141]),der(x[142]),der(x[143]),der(x[144]),der(x[145]),der(x[146]),der(x[147]),der(x[148]),der(x[149]),der(x[14]),der(x[150]),der(x[151]),der(x[152]),der(x[153]),der(x[154]),der(x[155]),der(x[156]),der(x[157]),der(x[158]),der(x[159]),der(x[15]),der(x[160]),der(x[161]),der(x[162]),der(x[163]),der(x[164]),der(x[165]),der(x[166]),der(x[167]),der(x[168]),der(x[169]),der(x[16]),der(x[170]),der(x[171]),der(x[172]),der(x[173]),der(x[174]),der(x[175]),der(x[176]),der(x[177]),der(x[178]),der(x[179]),der(x[17]),der(x[180]),der(x[181]),der(x[182]),der(x[183]),der(x[184]),der(x[185]),der(x[186]),der(x[187]),der(x[188]),der(x[189]),der(x[18]),der(x[190]),der(x[191]),der(x[192]),der(x[193]),der(x[194]),der(x[195]),der(x[196]),der(x[197]),der(x[198]),der(x[199]),der(x[19]),der(x[1]),der(x[200]),der(x[201]),der(x[202]),der(x[203]),der(x[204]),der(x[205]),der(x[206]),der(x[207]),der(x[208]),der(x[209]),der(x[20]),der(x[210]),der(x[211]),der(x[212]),der(x[213]),der(x[214]),der(x[215]),der(x[216]),der(x[217]),der(x[218]),der(x[219]),der(x[21]),der(x[220]),der(x[221]),der(x[222]),der(x[223]),der(x[224]),der(x[225]),der(x[226]),der(x[227]),der(x[228]),der(x[229]),der(x[22]),der(x[230]),der(x[231]),der(x[232]),der(x[233]),der(x[234]),der(x[235]),der(x[236]),der(x[237]),der(x[238]),der(x[239]),der(x[23]),der(x[240]),der(x[241]),der(x[242]),der(x[243]),der(x[244]),der(x[245]),der(x[246]),der(x[247]),der(x[248]),der(x[249]),der(x[24]),der(x[250]),der(x[251]),der(x[252]),der(x[253]),der(x[254]),der(x[255]),der(x[256]),der(x[257]),der(x[258]),der(x[259]),der(x[25]),der(x[260]),der(x[261]),der(x[262]),der(x[263]),der(x[264]),der(x[265]),der(x[266]),der(x[267]),der(x[268]),der(x[269]),der(x[26]),der(x[270]),der(x[271]),der(x[272]),der(x[273]),der(x[274]),der(x[275]),der(x[276]),der(x[277]),der(x[278]),der(x[279]),der(x[27]),der(x[280]),der(x[281]),der(x[282]),der(x[283]),der(x[284]),der(x[285]),der(x[286]),der(x[287]),der(x[288]),der(x[289]),der(x[28]),der(x[290]),der(x[291]),der(x[292]),der(x[293]),der(x[294]),der(x[295]),der(x[296]),der(x[297]),der(x[298]),der(x[299]),der(x[29]),der(x[2]),der(x[300]),der(x[301]),der(x[302]),der(x[303]),der(x[304]),der(x[305]),der(x[306]),der(x[307]),der(x[308]),der(x[309]),der(x[30]),der(x[310]),der(x[311]),der(x[312]),der(x[313]),der(x[314]),der(x[315]),der(x[316]),der(x[317]),der(x[318]),der(x[319]),der(x[31]),der(x[320]),der(x[321]),der(x[322]),der(x[323]),der(x[324]),der(x[325]),der(x[326]),der(x[327]),der(x[328]),der(x[329]),der(x[32]),der(x[330]),der(x[331]),der(x[332]),der(x[333]),der(x[334]),der(x[335]),der(x[336]),der(x[337]),der(x[338]),der(x[339]),der(x[33]),der(x[340]),der(x[341]),der(x[342]),der(x[343]),der(x[344]),der(x[345]),der(x[346]),der(x[347]),der(x[348]),der(x[349]),der(x[34]),der(x[350]),der(x[351]),der(x[352]),der(x[353]),der(x[354]),der(x[355]),der(x[356]),der(x[357]),der(x[358]),der(x[359]),der(x[35]),der(x[360]),der(x[361]),der(x[362]),der(x[363]),der(x[364]),der(x[365]),der(x[366]),der(x[367]),der(x[368]),der(x[369]),der(x[36]),der(x[370]),der(x[371]),der(x[372]),der(x[373]),der(x[374]),der(x[375]),der(x[376]),der(x[377]),der(x[378]),der(x[379]),der(x[37]),der(x[380]),der(x[381]),der(x[382]),der(x[383]),der(x[384]),der(x[385]),der(x[386]),der(x[387]),der(x[388]),der(x[389]),der(x[38]),der(x[390]),der(x[391]),der(x[392]),der(x[393]),der(x[394]),der(x[395]),der(x[396]),der(x[397]),der(x[398]),der(x[399]),der(x[39]),der(x[3]),der(x[400]),der(x[40]),der(x[41]),der(x[42]),der(x[43]),der(x[44]),der(x[45]),der(x[46]),der(x[47]),der(x[48]),der(x[49]),der(x[4]),der(x[50]),der(x[51]),der(x[52]),der(x[53]),der(x[54]),der(x[55]),der(x[56]),der(x[57]),der(x[58]),der(x[59]),der(x[5]),der(x[60]),der(x[61]),der(x[62]),der(x[63]),der(x[64]),der(x[65]),der(x[66]),der(x[67]),der(x[68]),der(x[69]),der(x[6]),der(x[70]),der(x[71]),der(x[72]),der(x[73]),der(x[74]),der(x[75]),der(x[76]),der(x[77]),der(x[78]),der(x[79]),der(x[7]),der(x[80]),der(x[81]),der(x[82]),der(x[83]),der(x[84]),der(x[85]),der(x[86]),der(x[87]),der(x[88]),der(x[89]),der(x[8]),der(x[90]),der(x[91]),der(x[92]),der(x[93]),der(x[94]),der(x[95]),der(x[96]),der(x[97]),der(x[98]),der(x[99]),der(x[9]),tau,time,u,x[100],x[101],x[102],x[103],x[104],x[105],x[106],x[107],x[108],x[109],x[10],x[110],x[111],x[112],x[113],x[114],x[115],x[116],x[117],x[118],x[119],x[11],x[120],x[121],x[122],x[123],x[124],x[125],x[126],x[127],x[128],x[129],x[12],x[130],x[131],x[132],x[133],x[134],x[135],x[136],x[137],x[138],x[139],x[13],x[140],x[141],x[142],x[143],x[144],x[145],x[146],x[147],x[148],x[149],x[14],x[150],x[151],x[152],x[153],x[154],x[155],x[156],x[157],x[158],x[159],x[15],x[160],x[161],x[162],x[163],x[164],x[165],x[166],x[167],x[168],x[169],x[16],x[170],x[171],x[172],x[173],x[174],x[175],x[176],x[177],x[178],x[179],x[17],x[180],x[181],x[182],x[183],x[184],x[185],x[186],x[187],x[188],x[189],x[18],x[190],x[191],x[192],x[193],x[194],x[195],x[196],x[197],x[198],x[199],x[19],x[1],x[200],x[201],x[202],x[203],x[204],x[205],x[206],x[207],x[208],x[209],x[20],x[210],x[211],x[212],x[213],x[214],x[215],x[216],x[217],x[218],x[219],x[21],x[220],x[221],x[222],x[223],x[224],x[225],x[226],x[227],x[228],x[229],x[22],x[230],x[231],x[232],x[233],x[234],x[235],x[236],x[237],x[238],x[239],x[23],x[240],x[241],x[242],x[243],x[244],x[245],x[246],x[247],x[248],x[249],x[24],x[250],x[251],x[252],x[253],x[254],x[255],x[256],x[257],x[258],x[259],x[25],x[260],x[261],x[262],x[263],x[264],x[265],x[266],x[267],x[268],x[269],x[26],x[270],x[271],x[272],x[273],x[274],x[275],x[276],x[277],x[278],x[279],x[27],x[280],x[281],x[282],x[283],x[284],x[285],x[286],x[287],x[288],x[289],x[28],x[290],x[291],x[292],x[293],x[294],x[295],x[296],x[297],x[298],x[299],x[29],x[2],x[300],x[301],x[302],x[303],x[304],x[305],x[306],x[307],x[308],x[309],x[30],x[310],x[311],x[312],x[313],x[314],x[315],x[316],x[317],x[318],x[319],x[31],x[320],x[321],x[322],x[323],x[324],x[325],x[326],x[327],x[328],x[329],x[32],x[330],x[331],x[332],x[333],x[334],x[335],x[336],x[337],x[338],x[339],x[33],x[340],x[341],x[342],x[343],x[344],x[345],x[346],x[347],x[348],x[349],x[34],x[350],x[351],x[352],x[353],x[354],x[355],x[356],x[357],x[358],x[359],x[35],x[360],x[361],x[362],x[363],x[364],x[365],x[366],x[367],x[368],x[369],x[36],x[370],x[371],x[372],x[373],x[374],x[375],x[376],x[377],x[378],x[379],x[37],x[380],x[381],x[382],x[383],x[384],x[385],x[386],x[387],x[388],x[389],x[38],x[390],x[391],x[392],x[393],x[394],x[395],x[396],x[397],x[398],x[399],x[39],x[3],x[400],x[40],x[41],x[42],x[43],x[44],x[45],x[46],x[47],x[48],x[49],x[4],x[50],x[51],x[52],x[53],x[54],x[55],x[56],x[57],x[58],x[59],x[5],x[60],x[61],x[62],x[63],x[64],x[65],x[66],x[67],x[68],x[69],x[6],x[70],x[71],x[72],x[73],x[74],x[75],x[76],x[77],x[78],x[79],x[7],x[80],x[81],x[82],x[83],x[84],x[85],x[86],x[87],x[88],x[89],x[8],x[90],x[91],x[92],x[93],x[94],x[95],x[96],x[97],x[98],x[99],x[9]
[Calling sys.exit(0), Time elapsed: 45.38126012595603]