Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array.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.00156/0.00156, allocations: 109.3 kB / 21.08 MB, free: 0.8438 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.001634/0.001634, allocations: 186.7 kB / 24.33 MB, free: 4.25 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.355/1.355, allocations: 225.6 MB / 253 MB, free: 13.05 MB / 206.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.9841/0.9841, allocations: 120.6 MB / 428.8 MB, free: 5.531 MB / 334.1 MB
"
[Timeout remaining time 179]
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.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array,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|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|der.firstOrder.y.|firstOrder.u|firstOrder.y|ground.p.i|ground.p.v|source.i|source.n.i|source.n.v|source.p.i|source.p.v|source.v|step.y|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array")
translateModel(ScalableTestSuite.Electrical.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array,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|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|der.firstOrder.y.|firstOrder.u|firstOrder.y|ground.p.i|ground.p.v|source.i|source.n.i|source.n.v|source.p.i|source.p.v|source.v|step.y|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Electrical.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 4.007e-05/4.007e-05, allocations: 6.219 kB / 0.5992 GB, free: 16.9 MB / 446.3 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Electrical.BreakerCircuits.Verification.BreakerNetworkDelayed_3_Array): time 0.002939/0.002979, allocations: 2.08 MB / 0.6013 GB, free: 14.8 MB / 446.3 MB
Notification: Performance of NFInst.instExpressions: time 0.0008569/0.003836, allocations: 0.5727 MB / 0.6018 GB, free: 14.23 MB / 446.3 MB
Notification: Performance of NFInst.updateImplicitVariability: time 8.789e-05/0.003924, allocations: 0 / 0.6018 GB, free: 14.23 MB / 446.3 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001485/0.004072, allocations: 27.73 kB / 0.6019 GB, free: 14.2 MB / 446.3 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002231/0.004296, allocations: 47.61 kB / 0.6019 GB, free: 14.15 MB / 446.3 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0002424/0.004538, allocations: 71.89 kB / 0.602 GB, free: 14.08 MB / 446.3 MB
Notification: Performance of NFFlatten.flatten: time 0.0004876/0.005026, allocations: 466.9 kB / 0.6024 GB, free: 13.62 MB / 446.3 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001657/0.005191, allocations: 88.16 kB / 0.6025 GB, free: 13.54 MB / 446.3 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001423/0.005334, allocations: 159.7 kB / 0.6027 GB, free: 13.38 MB / 446.3 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001715/0.005505, allocations: 175.5 kB / 0.6028 GB, free: 13.21 MB / 446.3 MB
Notification: Performance of NFPackage.collectConstants: time 3.952e-05/0.005545, allocations: 20 kB / 0.6028 GB, free: 13.19 MB / 446.3 MB
Notification: Performance of NFFlatten.collectFunctions: time 5.833e-05/0.005603, allocations: 31.94 kB / 0.6029 GB, free: 13.16 MB / 446.3 MB
Notification: Performance of combineBinaries: time 0.0002667/0.00587, allocations: 432.8 kB / 0.6033 GB, free: 12.73 MB / 446.3 MB
Notification: Performance of replaceArrayConstructors: time 0.0001089/0.005979, allocations: 261.5 kB / 0.6035 GB, free: 12.48 MB / 446.3 MB
Notification: Performance of NFVerifyModel.verify: time 4.281e-05/0.006021, allocations: 31.88 kB / 0.6036 GB, free: 12.45 MB / 446.3 MB
Notification: Performance of FrontEnd: time 2.82e-05/0.00605, allocations: 4 kB / 0.6036 GB, free: 12.44 MB / 446.3 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 77 (39)
 * Number of variables: 77 (30)
Notification: Performance of Bindings: time 0.001206/0.007255, allocations: 1.334 MB / 0.6049 GB, free: 10.98 MB / 446.3 MB
Notification: Performance of FunctionAlias: time 8.868e-05/0.007344, allocations: 119.8 kB / 0.605 GB, free: 10.85 MB / 446.3 MB
Notification: Performance of Early Inline: time 0.0003754/0.00772, allocations: 0.6481 MB / 0.6056 GB, free: 10.18 MB / 446.3 MB
Notification: Performance of Simplify 1: time 0.0001207/0.00784, allocations: 141.9 kB / 0.6058 GB, free: 9.992 MB / 446.3 MB
Notification: Performance of Alias: time 0.0006463/0.008486, allocations: 0.5595 MB / 0.6063 GB, free: 9.359 MB / 446.3 MB
Notification: Performance of Simplify 2: time 0.0001092/0.008596, allocations: 140.6 kB / 0.6064 GB, free: 9.176 MB / 446.3 MB
Notification: Performance of Remove Stream: time 7.121e-05/0.008667, allocations: 110.9 kB / 0.6065 GB, free: 9.039 MB / 446.3 MB
Notification: Performance of Detect States: time 0.0002209/0.008888, allocations: 241 kB / 0.6068 GB, free: 8.754 MB / 446.3 MB
Notification: Performance of Events: time 0.0001356/0.009023, allocations: 99.73 kB / 0.6069 GB, free: 8.652 MB / 446.3 MB
Notification: Performance of Partitioning: time 0.0002107/0.009234, allocations: 254.2 kB / 0.6071 GB, free: 8.398 MB / 446.3 MB
Notification: Performance of Causalize: time 0.001066/0.0103, allocations: 1.252 MB / 0.6083 GB, free: 7.16 MB / 446.3 MB
Notification: Performance of After Index Reduction Inline: time 0.0003677/0.01067, allocations: 0.6828 MB / 0.609 GB, free: 6.477 MB / 446.3 MB
Notification: Performance of Simplify: time 0.0004533/0.01112, allocations: 409 kB / 0.6094 GB, free: 6.012 MB / 446.3 MB
Notification: Performance of Inline: time 0.0005741/0.01169, allocations: 1.031 MB / 0.6104 GB, free: 4.965 MB / 446.3 MB
Notification: Performance of Partitioning: time 2.399e-05/0.01172, allocations: 18.75 kB / 0.6104 GB, free: 4.938 MB / 446.3 MB
Notification: Performance of Cleanup: time 0.0001053/0.01182, allocations: 163.9 kB / 0.6106 GB, free: 4.777 MB / 446.3 MB
Notification: Performance of Causalize: time 0.001344/0.01317, allocations: 1.592 MB / 0.6121 GB, free: 3.215 MB / 446.3 MB
Notification: Performance of Tearing: time 0.0007747/0.01394, allocations: 0.9123 MB / 0.613 GB, free: 2.254 MB / 446.3 MB
Notification: Performance of Initialization: time 5.01e-07/0.01394, allocations: 0 / 0.613 GB, free: 2.254 MB / 446.3 MB
Notification: Performance of Remove Dummies: time 5.53e-06/0.01395, allocations: 192 / 0.613 GB, free: 2.254 MB / 446.3 MB
Notification: Performance of Tearing: time 0.0006621/0.01461, allocations: 0.8768 MB / 0.6139 GB, free: 1.332 MB / 446.3 MB
Notification: Performance of Categorize: time 9.137e-06/0.01462, allocations: 0 / 0.6139 GB, free: 1.332 MB / 446.3 MB
Notification: Performance of Solve: time 0.0002136/0.01483, allocations: 130.1 kB / 0.614 GB, free: 1.207 MB / 446.3 MB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBStrongComponent.mo:1009:9-1011:16:writable] Error: Internal error UnorderedMap.getSafe failed because the key did not exist.
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 3.707640898413956]
Failed to read output from testmodel.py, exit status != 0:
0.022296171635389328 0.03598452 0.027179317
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fa6b9de5780>