Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001932/0.001932, allocations: 124.6 kB / 17.79 MB, free: 5.266 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002144/0.002144, allocations: 185.2 kB / 20.73 MB, free: 2.332 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.629/1.629, allocations: 225.6 MB / 249.1 MB, free: 3.617 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo): time 0.9614/0.9614, allocations: 120.6 MB / 424.6 MB, free: 5.562 MB / 350.1 MB
"
[Timeout remaining time 178]
Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/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 Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 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)
Running command: translateModel(ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640,tolerance=1e-08,outputFormat="mat",numberOfIntervals=1999,variableFilter="cur.1.|cur.2.|cur.3.|cur.4.|cur.5.|cur.640.|der.cur.1..|der.cur.2..|der.cur.3..|der.cur.4..|der.cur.5..|der.vol.1..|der.vol.2..|der.vol.3..|der.vol.4..|der.vol.5..|der.vol.640..|time|time|vol.1.|vol.2.|vol.3.|vol.4.|vol.5.|vol.640.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640")
translateModel(ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640,tolerance=1e-08,outputFormat="mat",numberOfIntervals=1999,variableFilter="cur.1.|cur.2.|cur.3.|cur.4.|cur.5.|cur.640.|der.cur.1..|der.cur.2..|der.cur.3..|der.cur.4..|der.cur.5..|der.vol.1..|der.vol.2..|der.vol.3..|der.vol.4..|der.vol.5..|der.vol.640..|time|time|vol.1.|vol.2.|vol.3.|vol.4.|vol.5.|vol.640.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002052/0.002052, allocations: 75.86 kB / 0.5951 GB, free: 1.121 MB / 494.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7291/0.7311, allocations: 84.64 MB / 0.6778 GB, free: 17.09 MB / 0.5139 GB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640): time 0.002399/0.7335, allocations: 1.35 MB / 0.6791 GB, free: 16.02 MB / 0.5139 GB
Notification: Performance of NFInst.instExpressions: time 0.0002493/0.7338, allocations: 58.78 kB / 0.6792 GB, free: 15.97 MB / 0.5139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 4.312e-05/0.7338, allocations: 1.375 kB / 0.6792 GB, free: 15.97 MB / 0.5139 GB
Notification: Performance of NFTyping.typeComponents: time 0.0001136/0.7339, allocations: 7.922 kB / 0.6792 GB, free: 15.96 MB / 0.5139 GB
Notification: Performance of NFTyping.typeBindings: time 9.452e-05/0.734, allocations: 19.97 kB / 0.6792 GB, free: 15.95 MB / 0.5139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0001599/0.7342, allocations: 24.03 kB / 0.6792 GB, free: 15.93 MB / 0.5139 GB
Notification: Performance of NFFlatten.flatten: time 0.007239/0.7414, allocations: 9.948 MB / 0.6889 GB, free: 10.62 MB / 0.5139 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002476/0.7417, allocations: 65.89 kB / 0.689 GB, free: 10.61 MB / 0.5139 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007408/0.7491, allocations: 3.444 MB / 0.6924 GB, free: 9.168 MB / 0.5139 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01003/0.7591, allocations: 4.864 MB / 0.6971 GB, free: 6.039 MB / 0.5139 GB
Notification: Performance of NFPackage.collectConstants: time 0.003866/0.763, allocations: 0.5476 MB / 0.6976 GB, free: 6.039 MB / 0.5139 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002958/0.7659, allocations: 0.5478 MB / 0.6982 GB, free: 6.039 MB / 0.5139 GB
Notification: Performance of NFScalarize.scalarize: time 0.003445/0.7694, allocations: 4.208 MB / 0.7023 GB, free: 1.98 MB / 0.5139 GB
Notification: Performance of NFVerifyModel.verify: time 0.008876/0.7783, allocations: 4.261 MB / 0.7065 GB, free: 13.7 MB / 0.5295 GB
Notification: Performance of NFConvertDAE.convert: time 0.01098/0.7892, allocations: 7.375 MB / 0.7137 GB, free: 6.309 MB / 0.5295 GB
Notification: Performance of FrontEnd - DAE generated: time 6.462e-06/0.7892, allocations: 4 kB / 0.7137 GB, free: 6.305 MB / 0.5295 GB
Notification: Performance of FrontEnd: time 2.024e-06/0.7892, allocations: 0 / 0.7137 GB, free: 6.305 MB / 0.5295 GB
Notification: Performance of Transformations before backend: time 0.0002805/0.7895, allocations: 0 / 0.7137 GB, free: 6.305 MB / 0.5295 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1921
 * Number of variables: 1921
Notification: Performance of Generate backend data structure: time 0.04846/0.838, allocations: 14.3 MB / 0.7276 GB, free: 7.914 MB / 0.5452 GB
Notification: Performance of prepare preOptimizeDAE: time 5.289e-05/0.838, allocations: 19.83 kB / 0.7276 GB, free: 7.895 MB / 0.5452 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002623/0.8407, allocations: 0.8525 MB / 0.7285 GB, free: 7.039 MB / 0.5452 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008773/0.8494, allocations: 2.499 MB / 0.7309 GB, free: 4.492 MB / 0.5452 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009706/0.8504, allocations: 0.8549 MB / 0.7317 GB, free: 3.637 MB / 0.5452 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004016/0.8544, allocations: 1.806 MB / 0.7335 GB, free: 1.828 MB / 0.5452 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02285/0.8773, allocations: 9.975 MB / 0.7433 GB, free: 7.82 MB / 0.5608 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001468/0.8774, allocations: 192 / 0.7433 GB, free: 7.82 MB / 0.5608 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00112/0.8785, allocations: 307.9 kB / 0.7435 GB, free: 7.52 MB / 0.5608 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001605/0.8787, allocations: 180 kB / 0.7437 GB, free: 7.344 MB / 0.5608 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01326/0.892, allocations: 6.011 MB / 0.7496 GB, free: 1.324 MB / 0.5608 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.08182/0.9738, allocations: 25.72 MB / 0.7747 GB, free: 7.516 MB / 0.592 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.1437/1.118, allocations: 42.95 MB / 0.8166 GB, free: 12.52 MB / 0.6389 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01574/1.133, allocations: 5.629 MB / 0.8221 GB, free: 6.875 MB / 0.6389 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003143/1.136, allocations: 130 kB / 0.8223 GB, free: 6.746 MB / 0.6389 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000244/1.137, allocations: 168.6 kB / 0.8224 GB, free: 6.57 MB / 0.6389 GB
Notification: Performance of pre-optimization done (n=1282): time 2.786e-05/1.137, allocations: 3.938 kB / 0.8224 GB, free: 6.566 MB / 0.6389 GB
Notification: Performance of matching and sorting (n=1282): time 0.04859/1.185, allocations: 17.05 MB / 0.8391 GB, free: 5.473 MB / 0.6545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001809/1.185, allocations: 181.4 kB / 0.8393 GB, free: 5.281 MB / 0.6545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001016/1.186, allocations: 0.5091 MB / 0.8398 GB, free: 4.762 MB / 0.6545 GB
Notification: Performance of collectPreVariables (initialization): time 0.003116/1.19, allocations: 425.7 kB / 0.8402 GB, free: 4.34 MB / 0.6545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001193/1.191, allocations: 1.168 MB / 0.8413 GB, free: 3.16 MB / 0.6545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008826/1.2, allocations: 6.139 MB / 0.8473 GB, free: 12.97 MB / 0.6702 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01203/1.212, allocations: 3.557 MB / 0.8508 GB, free: 9.395 MB / 0.6702 GB
Notification: Performance of setup shared object (initialization): time 0.0001843/1.212, allocations: 310 kB / 0.8511 GB, free: 9.086 MB / 0.6702 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01784/1.23, allocations: 6.975 MB / 0.8579 GB, free: 2.098 MB / 0.6702 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0186/1.248, allocations: 7.265 MB / 0.865 GB, free: 10.84 MB / 0.6858 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03593/1.284, allocations: 15.56 MB / 0.8802 GB, free: 11.19 MB / 0.7014 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.732e-05/1.284, allocations: 0 / 0.8802 GB, free: 11.19 MB / 0.7014 GB
Notification: Performance of matching and sorting (n=2562) (initialization): time 0.7708/2.055, allocations: 18.79 MB / 0.8985 GB, free: 170.4 MB / 0.7017 GB
Notification: Performance of prepare postOptimizeDAE: time 5.887e-05/2.055, allocations: 5.5 kB / 0.8985 GB, free: 170.4 MB / 0.7017 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.808e-05/2.055, allocations: 3.688 kB / 0.8985 GB, free: 170.4 MB / 0.7017 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001423/2.055, allocations: 80.88 kB / 0.8986 GB, free: 170.4 MB / 0.7017 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03043/2.086, allocations: 6.935 MB / 0.9054 GB, free: 169.8 MB / 0.7017 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008644/2.087, allocations: 80.34 kB / 0.9055 GB, free: 169.8 MB / 0.7017 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01162/2.098, allocations: 1.956 MB / 0.9074 GB, free: 169.4 MB / 0.7017 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004216/2.102, allocations: 0.5468 MB / 0.9079 GB, free: 169.2 MB / 0.7017 GB
Notification: Model statistics after passing the back-end for initialization:
 * 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 initialization (2562):
 * Single equations (assignments): 2562
 * 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.008244/2.111, allocations: 1.659 MB / 0.9095 GB, free: 168.4 MB / 0.7017 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003108/2.114, allocations: 0.4937 MB / 0.91 GB, free: 168.4 MB / 0.7017 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003034/2.117, allocations: 1.343 MB / 0.9113 GB, free: 167.1 MB / 0.7017 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001491/2.117, allocations: 124.1 kB / 0.9114 GB, free: 167.1 MB / 0.7017 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001176/2.117, allocations: 5.125 kB / 0.9114 GB, free: 167.1 MB / 0.7017 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.664e-05/2.117, allocations: 61.59 kB / 0.9115 GB, free: 167.1 MB / 0.7017 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01344/2.131, allocations: 7.505 MB / 0.9188 GB, free: 165 MB / 0.7017 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.026e-05/2.131, allocations: 0 / 0.9188 GB, free: 165 MB / 0.7017 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0369/2.168, allocations: 6.975 MB / 0.9256 GB, free: 164.5 MB / 0.7017 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0002563/2.168, allocations: 41.06 kB / 0.9257 GB, free: 164.5 MB / 0.7017 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003249/2.171, allocations: 0.78 MB / 0.9264 GB, free: 164.3 MB / 0.7017 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 6.47e-05/2.171, allocations: 41.5 kB / 0.9265 GB, free: 164.3 MB / 0.7017 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.677e-06/2.171, allocations: 1.688 kB / 0.9265 GB, free: 164.3 MB / 0.7017 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04097/2.212, allocations: 18.42 MB / 0.9445 GB, free: 155.9 MB / 0.7017 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001132/2.213, allocations: 0.6266 MB / 0.9451 GB, free: 155.5 MB / 0.7017 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003596/2.217, allocations: 0.6829 MB / 0.9457 GB, free: 154.8 MB / 0.7017 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00953/2.226, allocations: 0.8155 MB / 0.9465 GB, free: 154 MB / 0.7017 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003397/2.23, allocations: 0.743 MB / 0.9473 GB, free: 153.2 MB / 0.7017 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002306/2.232, allocations: 383.8 kB / 0.9476 GB, free: 152.9 MB / 0.7017 GB
Notification: Performance of sorting global known variables: time 8.227e-05/2.232, allocations: 91.27 kB / 0.9477 GB, free: 152.8 MB / 0.7017 GB
Notification: Performance of sort global known variables: time 6e-08/2.232, allocations: 0 / 0.9477 GB, free: 152.8 MB / 0.7017 GB
Notification: Performance of remove unused functions: time 0.01033/2.242, allocations: 3.562 MB / 0.9512 GB, free: 149.3 MB / 0.7017 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 1280 (cur_x[1],cur_x[2],cur_x[3],cur_x[4],cur_x[5],cur_x[6],cur_x[7],cur_x[8],cur_x[9],cur_x[10],cur_x[11],cur_x[12],cur_x[13],cur_x[14],cur_x[15],cur_x[16],cur_x[17],cur_x[18],cur_x[19],cur_x[20],cur_x[21],cur_x[22],cur_x[23],cur_x[24],cur_x[25],cur_x[26],cur_x[27],cur_x[28],cur_x[29],cur_x[30],cur_x[31],cur_x[32],cur_x[33],cur_x[34],cur_x[35],cur_x[36],cur_x[37],cur_x[38],cur_x[39],cur_x[40],cur_x[41],cur_x[42],cur_x[43],cur_x[44],cur_x[45],cur_x[46],cur_x[47],cur_x[48],cur_x[49],cur_x[50],cur_x[51],cur_x[52],cur_x[53],cur_x[54],cur_x[55],cur_x[56],cur_x[57],cur_x[58],cur_x[59],cur_x[60],cur_x[61],cur_x[62],cur_x[63],cur_x[64],cur_x[65],cur_x[66],cur_x[67],cur_x[68],cur_x[69],cur_x[70],cur_x[71],cur_x[72],cur_x[73],cur_x[74],cur_x[75],cur_x[76],cur_x[77],cur_x[78],cur_x[79],cur_x[80],cur_x[81],cur_x[82],cur_x[83],cur_x[84],cur_x[85],cur_x[86],cur_x[87],cur_x[88],cur_x[89],cur_x[90],cur_x[91],cur_x[92],cur_x[93],cur_x[94],cur_x[95],cur_x[96],cur_x[97],cur_x[98],cur_x[99],cur_x[100],cur_x[101],cur_x[102],cur_x[103],cur_x[104],cur_x[105],cur_x[106],cur_x[107],cur_x[108],cur_x[109],cur_x[110],cur_x[111],cur_x[112],cur_x[113],cur_x[114],cur_x[115],cur_x[116],cur_x[117],cur_x[118],cur_x[119],cur_x[120],cur_x[121],cur_x[122],cur_x[123],cur_x[124],cur_x[125],cur_x[126],cur_x[127],cur_x[128],cur_x[129],cur_x[130],cur_x[131],cur_x[132],cur_x[133],cur_x[134],cur_x[135],cur_x[136],cur_x[137],cur_x[138],cur_x[139],cur_x[140],cur_x[141],cur_x[142],cur_x[143],cur_x[144],cur_x[145],cur_x[146],cur_x[147],cur_x[148],cur_x[149],cur_x[150],cur_x[151],cur_x[152],cur_x[153],cur_x[154],cur_x[155],cur_x[156],cur_x[157],cur_x[158],cur_x[159],cur_x[160],cur_x[161],cur_x[162],cur_x[163],cur_x[164],cur_x[165],cur_x[166],cur_x[167],cur_x[168],cur_x[169],cur_x[170],cur_x[171],cur_x[172],cur_x[173],cur_x[174],cur_x[175],cur_x[176],cur_x[177],cur_x[178],cur_x[179],cur_x[180],cur_x[181],cur_x[182],cur_x[183],cur_x[184],cur_x[185],cur_x[186],cur_x[187],cur_x[188],cur_x[189],cur_x[190],cur_x[191],cur_x[192],cur_x[193],cur_x[194],cur_x[195],cur_x[196],cur_x[197],cur_x[198],cur_x[199],cur_x[200],cur_x[201],cur_x[202],cur_x[203],cur_x[204],cur_x[205],cur_x[206],cur_x[207],cur_x[208],cur_x[209],cur_x[210],cur_x[211],cur_x[212],cur_x[213],cur_x[214],cur_x[215],cur_x[216],cur_x[217],cur_x[218],cur_x[219],cur_x[220],cur_x[221],cur_x[222],cur_x[223],cur_x[224],cur_x[225],cur_x[226],cur_x[227],cur_x[228],cur_x[229],cur_x[230],cur_x[231],cur_x[232],cur_x[233],cur_x[234],cur_x[235],cur_x[236],cur_x[237],cur_x[238],cur_x[239],cur_x[240],cur_x[241],cur_x[242],cur_x[243],cur_x[244],cur_x[245],cur_x[246],cur_x[247],cur_x[248],cur_x[249],cur_x[250],cur_x[251],cur_x[252],cur_x[253],cur_x[254],cur_x[255],cur_x[256],cur_x[257],cur_x[258],cur_x[259],cur_x[260],cur_x[261],cur_x[262],cur_x[263],cur_x[264],cur_x[265],cur_x[266],cur_x[267],cur_x[268],cur_x[269],cur_x[270],cur_x[271],cur_x[272],cur_x[273],cur_x[274],cur_x[275],cur_x[276],cur_x[277],cur_x[278],cur_x[279],cur_x[280],cur_x[281],cur_x[282],cur_x[283],cur_x[284],cur_x[285],cur_x[286],cur_x[287],cur_x[288],cur_x[289],cur_x[290],cur_x[291],cur_x[292],cur_x[293],cur_x[294],cur_x[295],cur_x[296],cur_x[297],cur_x[298],cur_x[299],cur_x[300],cur_x[301],cur_x[302],cur_x[303],cur_x[304],cur_x[305],cur_x[306],cur_x[307],cur_x[308],cur_x[309],cur_x[310],cur_x[311],cur_x[312],cur_x[313],cur_x[314],cur_x[315],cur_x[316],cur_x[317],cur_x[318],cur_x[319],cur_x[320],cur_x[321],cur_x[322],cur_x[323],cur_x[324],cur_x[325],cur_x[326],cur_x[327],cur_x[328],cur_x[329],cur_x[330],cur_x[331],cur_x[332],cur_x[333],cur_x[334],cur_x[335],cur_x[336],cur_x[337],cur_x[338],cur_x[339],cur_x[340],cur_x[341],cur_x[342],cur_x[343],cur_x[344],cur_x[345],cur_x[346],cur_x[347],cur_x[348],cur_x[349],cur_x[350],cur_x[351],cur_x[352],cur_x[353],cur_x[354],cur_x[355],cur_x[356],cur_x[357],cur_x[358],cur_x[359],cur_x[360],cur_x[361],cur_x[362],cur_x[363],cur_x[364],cur_x[365],cur_x[366],cur_x[367],cur_x[368],cur_x[369],cur_x[370],cur_x[371],cur_x[372],cur_x[373],cur_x[374],cur_x[375],cur_x[376],cur_x[377],cur_x[378],cur_x[379],cur_x[380],cur_x[381],cur_x[382],cur_x[383],cur_x[384],cur_x[385],cur_x[386],cur_x[387],cur_x[388],cur_x[389],cur_x[390],cur_x[391],cur_x[392],cur_x[393],cur_x[394],cur_x[395],cur_x[396],cur_x[397],cur_x[398],cur_x[399],cur_x[400],cur_x[401],cur_x[402],cur_x[403],cur_x[404],cur_x[405],cur_x[406],cur_x[407],cur_x[408],cur_x[409],cur_x[410],cur_x[411],cur_x[412],cur_x[413],cur_x[414],cur_x[415],cur_x[416],cur_x[417],cur_x[418],cur_x[419],cur_x[420],cur_x[421],cur_x[422],cur_x[423],cur_x[424],cur_x[425],cur_x[426],cur_x[427],cur_x[428],cur_x[429],cur_x[430],cur_x[431],cur_x[432],cur_x[433],cur_x[434],cur_x[435],cur_x[436],cur_x[437],cur_x[438],cur_x[439],cur_x[440],cur_x[441],cur_x[442],cur_x[443],cur_x[444],cur_x[445],cur_x[446],cur_x[447],cur_x[448],cur_x[449],cur_x[450],cur_x[451],cur_x[452],cur_x[453],cur_x[454],cur_x[455],cur_x[456],cur_x[457],cur_x[458],cur_x[459],cur_x[460],cur_x[461],cur_x[462],cur_x[463],cur_x[464],cur_x[465],cur_x[466],cur_x[467],cur_x[468],cur_x[469],cur_x[470],cur_x[471],cur_x[472],cur_x[473],cur_x[474],cur_x[475],cur_x[476],cur_x[477],cur_x[478],cur_x[479],cur_x[480],cur_x[481],cur_x[482],cur_x[483],cur_x[484],cur_x[485],cur_x[486],cur_x[487],cur_x[488],cur_x[489],cur_x[490],cur_x[491],cur_x[492],cur_x[493],cur_x[494],cur_x[495],cur_x[496],cur_x[497],cur_x[498],cur_x[499],cur_x[500],cur_x[501],cur_x[502],cur_x[503],cur_x[504],cur_x[505],cur_x[506],cur_x[507],cur_x[508],cur_x[509],cur_x[510],cur_x[511],cur_x[512],cur_x[513],cur_x[514],cur_x[515],cur_x[516],cur_x[517],cur_x[518],cur_x[519],cur_x[520],cur_x[521],cur_x[522],cur_x[523],cur_x[524],cur_x[525],cur_x[526],cur_x[527],cur_x[528],cur_x[529],cur_x[530],cur_x[531],cur_x[532],cur_x[533],cur_x[534],cur_x[535],cur_x[536],cur_x[537],cur_x[538],cur_x[539],cur_x[540],cur_x[541],cur_x[542],cur_x[543],cur_x[544],cur_x[545],cur_x[546],cur_x[547],cur_x[548],cur_x[549],cur_x[550],cur_x[551],cur_x[552],cur_x[553],cur_x[554],cur_x[555],cur_x[556],cur_x[557],cur_x[558],cur_x[559],cur_x[560],cur_x[561],cur_x[562],cur_x[563],cur_x[564],cur_x[565],cur_x[566],cur_x[567],cur_x[568],cur_x[569],cur_x[570],cur_x[571],cur_x[572],cur_x[573],cur_x[574],cur_x[575],cur_x[576],cur_x[577],cur_x[578],cur_x[579],cur_x[580],cur_x[581],cur_x[582],cur_x[583],cur_x[584],cur_x[585],cur_x[586],cur_x[587],cur_x[588],cur_x[589],cur_x[590],cur_x[591],cur_x[592],cur_x[593],cur_x[594],cur_x[595],cur_x[596],cur_x[597],cur_x[598],cur_x[599],cur_x[600],cur_x[601],cur_x[602],cur_x[603],cur_x[604],cur_x[605],cur_x[606],cur_x[607],cur_x[608],cur_x[609],cur_x[610],cur_x[611],cur_x[612],cur_x[613],cur_x[614],cur_x[615],cur_x[616],cur_x[617],cur_x[618],cur_x[619],cur_x[620],cur_x[621],cur_x[622],cur_x[623],cur_x[624],cur_x[625],cur_x[626],cur_x[627],cur_x[628],cur_x[629],cur_x[630],cur_x[631],cur_x[632],cur_x[633],cur_x[634],cur_x[635],cur_x[636],cur_x[637],cur_x[638],cur_x[639],vol[1],vol[2],vol[3],vol[4],vol[5],vol[6],vol[7],vol[8],vol[9],vol[10],vol[11],vol[12],vol[13],vol[14],vol[15],vol[16],vol[17],vol[18],vol[19],vol[20],vol[21],vol[22],vol[23],vol[24],vol[25],vol[26],vol[27],vol[28],vol[29],vol[30],vol[31],vol[32],vol[33],vol[34],vol[35],vol[36],vol[37],vol[38],vol[39],vol[40],vol[41],vol[42],vol[43],vol[44],vol[45],vol[46],vol[47],vol[48],vol[49],vol[50],vol[51],vol[52],vol[53],vol[54],vol[55],vol[56],vol[57],vol[58],vol[59],vol[60],vol[61],vol[62],vol[63],vol[64],vol[65],vol[66],vol[67],vol[68],vol[69],vol[70],vol[71],vol[72],vol[73],vol[74],vol[75],vol[76],vol[77],vol[78],vol[79],vol[80],vol[81],vol[82],vol[83],vol[84],vol[85],vol[86],vol[87],vol[88],vol[89],vol[90],vol[91],vol[92],vol[93],vol[94],vol[95],vol[96],vol[97],vol[98],vol[99],vol[100],vol[101],vol[102],vol[103],vol[104],vol[105],vol[106],vol[107],vol[108],vol[109],vol[110],vol[111],vol[112],vol[113],vol[114],vol[115],vol[116],vol[117],vol[118],vol[119],vol[120],vol[121],vol[122],vol[123],vol[124],vol[125],vol[126],vol[127],vol[128],vol[129],vol[130],vol[131],vol[132],vol[133],vol[134],vol[135],vol[136],vol[137],vol[138],vol[139],vol[140],vol[141],vol[142],vol[143],vol[144],vol[145],vol[146],vol[147],vol[148],vol[149],vol[150],vol[151],vol[152],vol[153],vol[154],vol[155],vol[156],vol[157],vol[158],vol[159],vol[160],vol[161],vol[162],vol[163],vol[164],vol[165],vol[166],vol[167],vol[168],vol[169],vol[170],vol[171],vol[172],vol[173],vol[174],vol[175],vol[176],vol[177],vol[178],vol[179],vol[180],vol[181],vol[182],vol[183],vol[184],vol[185],vol[186],vol[187],vol[188],vol[189],vol[190],vol[191],vol[192],vol[193],vol[194],vol[195],vol[196],vol[197],vol[198],vol[199],vol[200],vol[201],vol[202],vol[203],vol[204],vol[205],vol[206],vol[207],vol[208],vol[209],vol[210],vol[211],vol[212],vol[213],vol[214],vol[215],vol[216],vol[217],vol[218],vol[219],vol[220],vol[221],vol[222],vol[223],vol[224],vol[225],vol[226],vol[227],vol[228],vol[229],vol[230],vol[231],vol[232],vol[233],vol[234],vol[235],vol[236],vol[237],vol[238],vol[239],vol[240],vol[241],vol[242],vol[243],vol[244],vol[245],vol[246],vol[247],vol[248],vol[249],vol[250],vol[251],vol[252],vol[253],vol[254],vol[255],vol[256],vol[257],vol[258],vol[259],vol[260],vol[261],vol[262],vol[263],vol[264],vol[265],vol[266],vol[267],vol[268],vol[269],vol[270],vol[271],vol[272],vol[273],vol[274],vol[275],vol[276],vol[277],vol[278],vol[279],vol[280],vol[281],vol[282],vol[283],vol[284],vol[285],vol[286],vol[287],vol[288],vol[289],vol[290],vol[291],vol[292],vol[293],vol[294],vol[295],vol[296],vol[297],vol[298],vol[299],vol[300],vol[301],vol[302],vol[303],vol[304],vol[305],vol[306],vol[307],vol[308],vol[309],vol[310],vol[311],vol[312],vol[313],vol[314],vol[315],vol[316],vol[317],vol[318],vol[319],vol[320],vol[321],vol[322],vol[323],vol[324],vol[325],vol[326],vol[327],vol[328],vol[329],vol[330],vol[331],vol[332],vol[333],vol[334],vol[335],vol[336],vol[337],vol[338],vol[339],vol[340],vol[341],vol[342],vol[343],vol[344],vol[345],vol[346],vol[347],vol[348],vol[349],vol[350],vol[351],vol[352],vol[353],vol[354],vol[355],vol[356],vol[357],vol[358],vol[359],vol[360],vol[361],vol[362],vol[363],vol[364],vol[365],vol[366],vol[367],vol[368],vol[369],vol[370],vol[371],vol[372],vol[373],vol[374],vol[375],vol[376],vol[377],vol[378],vol[379],vol[380],vol[381],vol[382],vol[383],vol[384],vol[385],vol[386],vol[387],vol[388],vol[389],vol[390],vol[391],vol[392],vol[393],vol[394],vol[395],vol[396],vol[397],vol[398],vol[399],vol[400],vol[401],vol[402],vol[403],vol[404],vol[405],vol[406],vol[407],vol[408],vol[409],vol[410],vol[411],vol[412],vol[413],vol[414],vol[415],vol[416],vol[417],vol[418],vol[419],vol[420],vol[421],vol[422],vol[423],vol[424],vol[425],vol[426],vol[427],vol[428],vol[429],vol[430],vol[431],vol[432],vol[433],vol[434],vol[435],vol[436],vol[437],vol[438],vol[439],vol[440],vol[441],vol[442],vol[443],vol[444],vol[445],vol[446],vol[447],vol[448],vol[449],vol[450],vol[451],vol[452],vol[453],vol[454],vol[455],vol[456],vol[457],vol[458],vol[459],vol[460],vol[461],vol[462],vol[463],vol[464],vol[465],vol[466],vol[467],vol[468],vol[469],vol[470],vol[471],vol[472],vol[473],vol[474],vol[475],vol[476],vol[477],vol[478],vol[479],vol[480],vol[481],vol[482],vol[483],vol[484],vol[485],vol[486],vol[487],vol[488],vol[489],vol[490],vol[491],vol[492],vol[493],vol[494],vol[495],vol[496],vol[497],vol[498],vol[499],vol[500],vol[501],vol[502],vol[503],vol[504],vol[505],vol[506],vol[507],vol[508],vol[509],vol[510],vol[511],vol[512],vol[513],vol[514],vol[515],vol[516],vol[517],vol[518],vol[519],vol[520],vol[521],vol[522],vol[523],vol[524],vol[525],vol[526],vol[527],vol[528],vol[529],vol[530],vol[531],vol[532],vol[533],vol[534],vol[535],vol[536],vol[537],vol[538],vol[539],vol[540],vol[541],vol[542],vol[543],vol[544],vol[545],vol[546],vol[547],vol[548],vol[549],vol[550],vol[551],vol[552],vol[553],vol[554],vol[555],vol[556],vol[557],vol[558],vol[559],vol[560],vol[561],vol[562],vol[563],vol[564],vol[565],vol[566],vol[567],vol[568],vol[569],vol[570],vol[571],vol[572],vol[573],vol[574],vol[575],vol[576],vol[577],vol[578],vol[579],vol[580],vol[581],vol[582],vol[583],vol[584],vol[585],vol[586],vol[587],vol[588],vol[589],vol[590],vol[591],vol[592],vol[593],vol[594],vol[595],vol[596],vol[597],vol[598],vol[599],vol[600],vol[601],vol[602],vol[603],vol[604],vol[605],vol[606],vol[607],vol[608],vol[609],vol[610],vol[611],vol[612],vol[613],vol[614],vol[615],vol[616],vol[617],vol[618],vol[619],vol[620],vol[621],vol[622],vol[623],vol[624],vol[625],vol[626],vol[627],vol[628],vol[629],vol[630],vol[631],vol[632],vol[633],vol[634],vol[635],vol[636],vol[637],vol[638],vol[639],vol[640],vvol)
 * 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 (1282):
 * Single equations (assignments): 1282
 * 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.004541/2.247, allocations: 1.159 MB / 0.9523 GB, free: 148.1 MB / 0.7017 GB
Notification: Performance of simCode: created initialization part: time 0.03301/2.28, allocations: 14.51 MB / 0.9665 GB, free: 133.6 MB / 0.7017 GB
Notification: Performance of simCode: created event and clocks part: time 8.757e-06/2.28, allocations: 0 / 0.9665 GB, free: 133.6 MB / 0.7017 GB
Notification: Performance of simCode: created simulation system equations: time 0.01399/2.294, allocations: 6.856 MB / 0.9732 GB, free: 126.8 MB / 0.7017 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.007453/2.301, allocations: 417.1 kB / 0.9736 GB, free: 126.4 MB / 0.7017 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.09271/2.394, allocations: 85.49 MB / 1.057 GB, free: 41.13 MB / 0.7017 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004789/2.399, allocations: 4.507 MB / 1.061 GB, free: 36.56 MB / 0.7017 GB
Notification: Performance of simCode: alias equations: time 0.0183/2.417, allocations: 5.056 MB / 1.066 GB, free: 31.5 MB / 0.7017 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005897/2.423, allocations: 0.558 MB / 1.067 GB, free: 30.94 MB / 0.7017 GB
Notification: Performance of SimCode: time 2.334e-06/2.423, allocations: 288 / 1.067 GB, free: 30.94 MB / 0.7017 GB
Notification: Performance of Templates: time 0.1758/2.599, allocations: 84.55 MB / 1.15 GB, free: 10.29 MB / 0.7642 GB
"
[Timeout remaining time 297]
make -j1 -f ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.makefile [Timeout 300]
(rm -f ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.pipe ; mkfifo ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.pipe ; head -c 1048576 < ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.pipe >> ../files/ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.sim & ./ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640  -s=ida -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.pipe 2>&1) [Timeout 300]
diffSimulationResults("ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/ReferenceFiles/ScalableTestSuite/ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
"Error: Could not read variable der(cur[1]) in file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat.
Warning: Get data of variable der(cur[1]) from file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat failed!
Error: Could not read variable der(cur[2]) in file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat.
Warning: Get data of variable der(cur[2]) from file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat failed!
Error: Could not read variable der(cur[3]) in file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat.
Warning: Get data of variable der(cur[3]) from file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat failed!
Error: Could not read variable der(cur[4]) in file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat.
Warning: Get data of variable der(cur[4]) from file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat failed!
Error: Could not read variable der(cur[5]) in file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat.
Warning: Get data of variable der(cur[5]) from file ScalableTestSuite_noopt_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_640_res.mat failed!
"
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 11.435796515084803]