Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10.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.001686/0.001686, allocations: 100.4 kB / 21.25 MB, free: 0.5703 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.001817/0.001817, allocations: 212.1 kB / 24.55 MB, free: 3.824 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.505/1.505, allocations: 230.6 MB / 258.3 MB, free: 7.77 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 1.155/1.155, allocations: 120.6 MB / 435.3 MB, free: 0.6523 MB / 334.1 MB " [Timeout remaining time 179] 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: translateModel(ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="B.1..G|B.1..i|B.1..n.i|B.1..n.v|B.1..open|B.1..p.i|B.1..p.v|B.1..timeClose|B.1..triggered|B.1..v|B.2..G|B.2..i|B.2..n.i|B.2..n.v|B.2..open|B.2..p.i|B.2..p.v|B.2..timeClose|B.2..triggered|B.2..v|B.3..G|B.3..i|B.3..n.i|B.3..n.v|B.3..open|B.3..p.i|B.3..p.v|B.3..timeClose|B.3..triggered|B.3..v|B.4..G|B.4..i|B.4..n.i|B.4..n.v|B.4..open|B.4..p.i|B.4..p.v|B.4..timeClose|B.4..triggered|B.4..v|B.5..G|B.5..i|B.5..n.i|B.5..n.v|B.5..open|B.5..p.i|B.5..p.v|B.5..timeClose|B.5..triggered|B.5..v|B.640..G|B.640..i|B.640..n.i|B.640..n.v|B.640..open|B.640..p.i|B.640..p.v|B.640..timeClose|B.640..triggered|B.640..v|G.1..G_actual|G.1..LossPower|G.1..i|G.1..n.i|G.1..n.v|G.1..p.i|G.1..p.v|G.1..v|G.2..G_actual|G.2..LossPower|G.2..i|G.2..n.i|G.2..n.v|G.2..p.i|G.2..p.v|G.2..v|G.3..G_actual|G.3..LossPower|G.3..i|G.3..n.i|G.3..n.v|G.3..p.i|G.3..p.v|G.3..v|G.4..G_actual|G.4..LossPower|G.4..i|G.4..n.i|G.4..n.v|G.4..p.i|G.4..p.v|G.4..v|G.5..G_actual|G.5..LossPower|G.5..i|G.5..n.i|G.5..n.v|G.5..p.i|G.5..p.v|G.5..v|G.640..G_actual|G.640..LossPower|G.640..i|G.640..n.i|G.640..n.v|G.640..p.i|G.640..p.v|G.640..v|G.641..i|G.641..v|G.6..i|G.6..v|ground.p.v|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10") translateModel(ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="B.1..G|B.1..i|B.1..n.i|B.1..n.v|B.1..open|B.1..p.i|B.1..p.v|B.1..timeClose|B.1..triggered|B.1..v|B.2..G|B.2..i|B.2..n.i|B.2..n.v|B.2..open|B.2..p.i|B.2..p.v|B.2..timeClose|B.2..triggered|B.2..v|B.3..G|B.3..i|B.3..n.i|B.3..n.v|B.3..open|B.3..p.i|B.3..p.v|B.3..timeClose|B.3..triggered|B.3..v|B.4..G|B.4..i|B.4..n.i|B.4..n.v|B.4..open|B.4..p.i|B.4..p.v|B.4..timeClose|B.4..triggered|B.4..v|B.5..G|B.5..i|B.5..n.i|B.5..n.v|B.5..open|B.5..p.i|B.5..p.v|B.5..timeClose|B.5..triggered|B.5..v|B.640..G|B.640..i|B.640..n.i|B.640..n.v|B.640..open|B.640..p.i|B.640..p.v|B.640..timeClose|B.640..triggered|B.640..v|G.1..G_actual|G.1..LossPower|G.1..i|G.1..n.i|G.1..n.v|G.1..p.i|G.1..p.v|G.1..v|G.2..G_actual|G.2..LossPower|G.2..i|G.2..n.i|G.2..n.v|G.2..p.i|G.2..p.v|G.2..v|G.3..G_actual|G.3..LossPower|G.3..i|G.3..n.i|G.3..n.v|G.3..p.i|G.3..p.v|G.3..v|G.4..G_actual|G.4..LossPower|G.4..i|G.4..n.i|G.4..n.v|G.4..p.i|G.4..p.v|G.4..v|G.5..G_actual|G.5..LossPower|G.5..i|G.5..n.i|G.5..n.v|G.5..p.i|G.5..p.v|G.5..v|G.640..G_actual|G.640..LossPower|G.640..i|G.640..n.i|G.640..n.v|G.640..p.i|G.640..p.v|G.640..v|G.641..i|G.641..v|G.6..i|G.6..v|ground.p.v|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.493e-05/2.493e-05, allocations: 2.281 kB / 0.608 GB, free: 10.28 MB / 446.3 MB Notification: Performance of NFInst.instantiate(ScalableTestSuite.Electrical.BreakerCircuits.ScaledExperiments.BreakerNetworkDelayed_N_640_M_10): time 0.003/0.003025, allocations: 2.042 MB / 0.61 GB, free: 8.223 MB / 446.3 MB Notification: Performance of NFInst.instExpressions: time 0.0009893/0.004014, allocations: 0.5689 MB / 0.6106 GB, free: 7.648 MB / 446.3 MB Notification: Performance of NFInst.updateImplicitVariability: time 9.631e-05/0.00411, allocations: 8 kB / 0.6106 GB, free: 7.641 MB / 446.3 MB Notification: Performance of NFTyping.typeComponents: time 0.0001338/0.004244, allocations: 19.8 kB / 0.6106 GB, free: 7.621 MB / 446.3 MB Notification: Performance of NFTyping.typeBindings: time 0.0002341/0.004478, allocations: 51.55 kB / 0.6106 GB, free: 7.57 MB / 446.3 MB Notification: Performance of NFTyping.typeClassSections: time 0.0002478/0.004726, allocations: 75.83 kB / 0.6107 GB, free: 7.496 MB / 446.3 MB Notification: Performance of NFFlatten.flatten: time 0.003232/0.007958, allocations: 5.977 MB / 0.6166 GB, free: 1.508 MB / 446.3 MB Notification: Performance of NFFlatten.resolveConnections: time 0.02345/0.03141, allocations: 10.94 MB / 0.6272 GB, free: 6.48 MB / 462.3 MB Notification: Performance of NFEvalConstants.evaluate: time 0.005212/0.03662, allocations: 3.229 MB / 0.6304 GB, free: 3.25 MB / 462.3 MB Notification: Performance of NFSimplifyModel.simplify: time 0.00686/0.04348, allocations: 3.395 MB / 0.6337 GB, free: 15.85 MB / 478.3 MB Notification: Performance of NFPackage.collectConstants: time 0.003253/0.04673, allocations: 1.188 MB / 0.6349 GB, free: 14.66 MB / 478.3 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003181/0.04992, allocations: 1.195 MB / 0.636 GB, free: 13.47 MB / 478.3 MB Notification: Performance of combineBinaries: time 0.009523/0.05944, allocations: 5.547 MB / 0.6414 GB, free: 7.914 MB / 478.3 MB Notification: Performance of replaceArrayConstructors: time 0.000659/0.0601, allocations: 333.5 kB / 0.6418 GB, free: 7.586 MB / 478.3 MB Notification: Performance of NFVerifyModel.verify: time 0.00249/0.06259, allocations: 496 kB / 0.6422 GB, free: 7.102 MB / 478.3 MB Notification: Performance of FrontEnd: time 9.348e-05/0.06268, allocations: 11.88 kB / 0.6422 GB, free: 7.09 MB / 478.3 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 12180 (2587) * Number of variables: 12180 (30) Notification: Performance of [SIM] Bindings: time 0.0322/0.09488, allocations: 21.29 MB / 0.663 GB, free: 1.488 MB / 494.3 MB Notification: Performance of [SIM] FunctionAlias: time 0.01109/0.106, allocations: 5.597 MB / 0.6685 GB, free: 11.87 MB / 0.4983 GB Notification: Performance of [SIM] Early Inline: time 0.04802/0.154, allocations: 32.02 MB / 0.6998 GB, free: 11.69 MB / 0.5295 GB Notification: Performance of [SIM] Simplify 1: time 0.01007/0.1641, allocations: 4.132 MB / 0.7038 GB, free: 7.395 MB / 0.5295 GB Notification: Performance of [SIM] Alias: time 0.03923/0.2033, allocations: 18.63 MB / 0.722 GB, free: 4.57 MB / 0.5452 GB Notification: Performance of [SIM] Simplify 2: time 0.01012/0.2134, allocations: 4.99 MB / 0.7269 GB, free: 15.38 MB / 0.5608 GB Notification: Performance of [SIM] Remove Stream: time 0.007031/0.2204, allocations: 3.352 MB / 0.7301 GB, free: 11.89 MB / 0.5608 GB Notification: Performance of [SIM] Detect States: time 0.01057/0.231, allocations: 6.428 MB / 0.7364 GB, free: 5.402 MB / 0.5608 GB Notification: Performance of [SIM] Events: time 0.001309/0.2323, allocations: 0.6895 MB / 0.7371 GB, free: 4.707 MB / 0.5608 GB Notification: Performance of [SIM] Partitioning: time 0.02597/0.2583, allocations: 13.53 MB / 0.7503 GB, free: 7.102 MB / 0.5764 GB Notification: Performance of [SIM] Causalize: time 21.99/22.25, allocations: 10.02 GB / 10.77 GB, free: 14.89 MB / 1.909 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.5397/22.79, allocations: 30.87 MB / 10.8 GB, free: 1.388 GB / 1.909 GB Notification: Performance of [INI] Simplify: time 0.02312/22.81, allocations: 9.372 MB / 10.8 GB, free: 1.386 GB / 1.909 GB Notification: Performance of [INI] Inline: time 0.0592/22.87, allocations: 46.67 MB / 10.85 GB, free: 1.355 GB / 1.909 GB Notification: Performance of [INI] Partitioning: time 0.001757/22.88, allocations: 430.8 kB / 10.85 GB, free: 1.355 GB / 1.909 GB Notification: Performance of [INI] Cleanup: time 0.01284/22.89, allocations: 6.802 MB / 10.86 GB, free: 1.348 GB / 1.909 GB Notification: Performance of [INI] Causalize: time 21.06/43.95, allocations: 10.58 GB / 21.44 GB, free: 0.5039 GB / 1.987 GB Notification: Performance of [INI] Tearing: time 0.01372/43.96, allocations: 8.588 MB / 21.45 GB, free: 0.5031 GB / 1.987 GB Notification: Performance of [SIM] Initialization: time 3.697e-06/43.96, allocations: 4 kB / 21.45 GB, free: 0.5031 GB / 1.987 GB Notification: Performance of [SIM] DAE-Mode: time 0.0227/43.99, allocations: 10.32 MB / 21.46 GB, free: 0.4999 GB / 1.987 GB Notification: Performance of [SIM] Remove Dummies: time 2.047e-05/43.99, allocations: 6.422 kB / 21.46 GB, free: 0.4999 GB / 1.987 GB Notification: Performance of [SIM] Tearing: time 0.0129/44, allocations: 9.843 MB / 21.47 GB, free: 0.4952 GB / 1.987 GB Notification: Performance of [SIM] Categorize: time 2.289e-05/44, allocations: 0 / 21.47 GB, free: 0.4952 GB / 1.987 GB Notification: Performance of [SIM] Solve: time 0.04608/44.04, allocations: 24.32 MB / 21.49 GB, free: 494.9 MB / 1.987 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref G[641].n.v is neither a seed nor a partial candidate! " [Timeout remaining time 256] [Calling sys.exit(0), Time elapsed: 48.2505503379507] Failed to read output from testmodel.py, exit status != 0: 44.10368845704943 44.115194629 44.049747279 Calling exit ...