Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.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.001714/0.001714, allocations: 99.61 kB / 21.25 MB, free: 0.5547 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.001813/0.001813, allocations: 208 kB / 24.55 MB, free: 3.828 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.437/1.437, allocations: 230.6 MB / 258.3 MB, free: 7.734 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.129/1.129, allocations: 120.6 MB / 435.3 MB, free: 0.6133 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.Elementary.Tables.ScaledExperiments.TimeTable_N_1000,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|time|timeTable.y",fileNamePrefix="ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000")
translateModel(ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|time|timeTable.y",fileNamePrefix="ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.115e-05/2.115e-05, allocations: 8.188 kB / 0.608 GB, free: 10.29 MB / 446.3 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000): time 0.002151/0.002172, allocations: 1.427 MB / 0.6094 GB, free: 8.852 MB / 446.3 MB
Notification: Performance of NFInst.instExpressions: time 0.0008705/0.003042, allocations: 0.5455 MB / 0.6099 GB, free: 8.301 MB / 446.3 MB
Notification: Performance of NFInst.updateImplicitVariability: time 5.964e-05/0.003102, allocations: 3.938 kB / 0.6099 GB, free: 8.297 MB / 446.3 MB
Notification: Performance of NFTyping.typeComponents: time 0.0004539/0.003556, allocations: 0.8654 MB / 0.6107 GB, free: 7.43 MB / 446.3 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005483/0.004104, allocations: 0.9121 MB / 0.6116 GB, free: 6.516 MB / 446.3 MB
Notification: Performance of NFTyping.typeClassSections: time 0.000266/0.00437, allocations: 75.05 kB / 0.6117 GB, free: 6.445 MB / 446.3 MB
Notification: Performance of NFFlatten.flatten: time 0.0009852/0.005355, allocations: 2.2 MB / 0.6139 GB, free: 4.242 MB / 446.3 MB
Notification: Performance of NFFlatten.resolveConnections: time 3.892e-05/0.005394, allocations: 3.984 kB / 0.6139 GB, free: 4.238 MB / 446.3 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0006718/0.006066, allocations: 1.1 MB / 0.6149 GB, free: 3.137 MB / 446.3 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001181/0.007247, allocations: 2.281 MB / 0.6172 GB, free: 0.8516 MB / 446.3 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002298/0.007477, allocations: 128 kB / 0.6173 GB, free: 0.7266 MB / 446.3 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003096/0.007787, allocations: 203.9 kB / 0.6175 GB, free: 0.5273 MB / 446.3 MB
Notification: Performance of combineBinaries: time 0.004152/0.01194, allocations: 3.76 MB / 0.6212 GB, free: 12.76 MB / 462.3 MB
Notification: Performance of replaceArrayConstructors: time 0.0004568/0.01239, allocations: 494.4 kB / 0.6216 GB, free: 12.28 MB / 462.3 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003952/0.01279, allocations: 4 kB / 0.6216 GB, free: 12.27 MB / 462.3 MB
Notification: Performance of FrontEnd: time 2.785e-05/0.01282, allocations: 0 / 0.6216 GB, free: 12.27 MB / 462.3 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 7 (3)
 * Number of variables: 7 (7)
Notification: Performance of [SIM] Bindings: time 0.004137/0.01695, allocations: 3.824 MB / 0.6254 GB, free: 8.324 MB / 462.3 MB
Notification: Performance of [SIM] FunctionAlias: time 6.217e-05/0.01702, allocations: 35.89 kB / 0.6254 GB, free: 8.277 MB / 462.3 MB
Notification: Performance of [SIM] Early Inline: time 0.0001745/0.01719, allocations: 140.3 kB / 0.6255 GB, free: 8.113 MB / 462.3 MB
Notification: Performance of [SIM] Simplify 1: time 0.0001335/0.01733, allocations: 80.66 kB / 0.6256 GB, free: 7.988 MB / 462.3 MB
Notification: Performance of [SIM] Alias: time 0.002106/0.01943, allocations: 0.7696 MB / 0.6264 GB, free: 7.16 MB / 462.3 MB
Notification: Performance of [SIM] Simplify 2: time 9.931e-05/0.01953, allocations: 76.73 kB / 0.6264 GB, free: 7.039 MB / 462.3 MB
Notification: Performance of [SIM] Remove Stream: time 6.704e-05/0.0196, allocations: 48.42 kB / 0.6265 GB, free: 6.965 MB / 462.3 MB
Notification: Performance of [SIM] Detect States: time 0.0002073/0.0198, allocations: 116.7 kB / 0.6266 GB, free: 6.797 MB / 462.3 MB
Notification: Performance of [SIM] Events: time 9.516e-05/0.0199, allocations: 12 kB / 0.6266 GB, free: 6.785 MB / 462.3 MB
Notification: Performance of [SIM] Partitioning: time 0.0001315/0.02003, allocations: 80.03 kB / 0.6267 GB, free: 6.699 MB / 462.3 MB
Notification: Performance of [SIM] Causalize: time 0.0001733/0.0202, allocations: 80.42 kB / 0.6268 GB, free: 6.613 MB / 462.3 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0001233/0.02033, allocations: 99.94 kB / 0.6268 GB, free: 6.516 MB / 462.3 MB
Notification: Performance of [INI] Simplify: time 0.009098/0.02943, allocations: 7.566 MB / 0.6342 GB, free: 14.87 MB / 478.3 MB
Notification: Performance of [INI] Inline: time 0.03292/0.06235, allocations: 36.16 MB / 0.6695 GB, free: 8.746 MB / 0.4983 GB
Notification: Performance of [INI] Partitioning: time 0.001526/0.06387, allocations: 295.5 kB / 0.6698 GB, free: 8.426 MB / 0.4983 GB
Notification: Performance of [INI] Cleanup: time 0.003133/0.06701, allocations: 1.206 MB / 0.671 GB, free: 7.219 MB / 0.4983 GB
Notification: Performance of [INI] Causalize: time 0.1053/0.1723, allocations: 73.27 MB / 0.7426 GB, free: 13.9 MB / 0.5764 GB
Notification: Performance of [INI] Tearing: time 0.0007148/0.173, allocations: 0.9844 MB / 0.7435 GB, free: 12.92 MB / 0.5764 GB
Notification: Performance of [SIM] Initialization: time 2.445e-06/0.173, allocations: 0 / 0.7435 GB, free: 12.92 MB / 0.5764 GB
Notification: Performance of [SIM] DAE-Mode: time 7.742e-05/0.1731, allocations: 12.12 kB / 0.7435 GB, free: 12.9 MB / 0.5764 GB
Notification: Performance of [SIM] Remove Dummies: time 5.169e-06/0.1731, allocations: 4 kB / 0.7435 GB, free: 12.89 MB / 0.5764 GB
Notification: Performance of [SIM] Tearing: time 1.302e-06/0.1731, allocations: 4 kB / 0.7435 GB, free: 12.89 MB / 0.5764 GB
Notification: Performance of [SIM] Categorize: time 1.212e-05/0.1731, allocations: 4.281 kB / 0.7435 GB, free: 12.89 MB / 0.5764 GB
Notification: Performance of [SIM] Solve: time 0.01637/0.1895, allocations: 7.288 MB / 0.7507 GB, free: 5.551 MB / 0.5764 GB
Notification: Performance of [SIM] Jacobian: time 0.00029/0.1898, allocations: 181.9 kB / 0.7508 GB, free: 5.34 MB / 0.5764 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 7 (7) {timeTable.a, timeTable.b, timeTable.last, timeTable.nextEvent, timeTable.nextEventScaled, $SEV_1, $SEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 1 (scalar:1, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 2002 (scalar:2002, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.000548/0.1903, allocations: 279.6 kB / 0.7511 GB, free: 5.074 MB / 0.5764 GB
Notification: Performance of SimCode: time 0.6321/0.8224, allocations: 28.25 MB / 0.7787 GB, free: 112.2 MB / 0.5767 GB
Notification: Performance of Templates: time 0.07024/0.8926, allocations: 34.04 MB / 0.8119 GB, free: 90.41 MB / 0.5767 GB
"
[Timeout remaining time 299]
make -j1 -f ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.makefile [Timeout 300]
(rm -f ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.pipe ; mkfifo ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.pipe ; head -c 1048576 < ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.pipe >> ../files/ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.sim & ./ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000  -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_ScalableTestSuite.Elementary.Tables.ScaledExperiments.TimeTable_N_1000.pipe 2>&1) [Timeout 300]
[Calling os._exit(0), Time elapsed: 8.659400456992444]
Failed to read output from testmodel.py, exit status != 0:
0.9003453199984506 0.909455426 0.8945540319999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe322ceedd0>