Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.conf.json
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.5461/0.5461, allocations: 120.7 MB / 141.1 MB, free: 12.23 MB / 126.2 MB
"
[Timeout remaining time 179]
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.001822/0.001822, allocations: 113.7 kB / 176.8 MB, free: 8.414 MB / 158.2 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.001326/0.001326, allocations: 195.1 kB / 212.6 MB, free: 12.29 MB / 174.5 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 0.4592/0.4592, allocations: 228.4 MB / 476.7 MB, free: 5.477 MB / 334.5 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/LargeTestSuite 2.2.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/LargeTestSuite 2.2.0-master/package.mo): time 0.004616/0.004616, allocations: 1.598 MB / 0.5528 GB, free: 2.012 MB / 382.5 MB
"
[Timeout remaining time 180]
Using package LargeTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/LargeTestSuite 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)
Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo)
Running command: translateModel(LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200,tolerance=0.0001,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200")
translateModel(LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200,tolerance=0.0001,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200") [Timeout 400]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.352e-05/1.352e-05, allocations: 4.141 kB / 0.7381 GB, free: 79.14 MB / 0.4985 GB
Notification: Performance of NFInst.instantiate(LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200): time 0.001454/0.001468, allocations: 1.258 MB / 0.7393 GB, free: 78.15 MB / 0.4985 GB
Notification: Performance of NFInst.instExpressions: time 0.0001398/0.001608, allocations: 37.11 kB / 0.7393 GB, free: 78.12 MB / 0.4985 GB
Notification: Performance of NFInst.updateImplicitVariability: time 2.41e-05/0.001632, allocations: 1.5 kB / 0.7393 GB, free: 78.12 MB / 0.4985 GB
Notification: Performance of NFTyping.typeComponents: time 6.57e-05/0.001698, allocations: 7.922 kB / 0.7394 GB, free: 78.11 MB / 0.4985 GB
Notification: Performance of NFTyping.typeBindings: time 4.308e-05/0.001741, allocations: 1.125 kB / 0.7394 GB, free: 78.11 MB / 0.4985 GB
Notification: Performance of NFTyping.typeClassSections: time 0.000115/0.001856, allocations: 20.39 kB / 0.7394 GB, free: 78.1 MB / 0.4985 GB
Notification: Performance of NFFlatten.flatten: time 7.95e-05/0.001935, allocations: 37.06 kB / 0.7394 GB, free: 78.08 MB / 0.4985 GB
Notification: Performance of NFFlatten.resolveArrayConnections: time 4.515e-05/0.00198, allocations: 22.02 kB / 0.7394 GB, free: 78.06 MB / 0.4985 GB
Notification: Performance of NFEvalConstants.evaluate: time 4.969e-05/0.00203, allocations: 25.88 kB / 0.7395 GB, free: 78.05 MB / 0.4985 GB
Notification: Performance of NFSimplifyModel.simplify: time 4.306e-05/0.002073, allocations: 18.67 kB / 0.7395 GB, free: 78.04 MB / 0.4985 GB
Notification: Performance of NFPackage.collectConstants: time 1.448e-05/0.002088, allocations: 2.219 kB / 0.7395 GB, free: 78.04 MB / 0.4985 GB
Notification: Performance of NFFlatten.collectFunctions: time 9.819e-06/0.002097, allocations: 2.719 kB / 0.7395 GB, free: 78.04 MB / 0.4985 GB
Notification: Performance of combineBinaries: time 5.401e-05/0.002151, allocations: 59.06 kB / 0.7395 GB, free: 78 MB / 0.4985 GB
Notification: Performance of replaceArrayConstructors: time 1.11e-05/0.002162, allocations: 20.06 kB / 0.7395 GB, free: 77.99 MB / 0.4985 GB
Notification: Performance of NFVerifyModel.verify: time 1.588e-05/0.002178, allocations: 2 kB / 0.7396 GB, free: 77.99 MB / 0.4985 GB
Notification: Performance of FrontEnd: time 6.612e-06/0.002185, allocations: 0 / 0.7396 GB, free: 77.99 MB / 0.4985 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6400 (4)
 * Number of variables: 6400 (2)
Notification: Performance of Bindings: time 0.0003061/0.002491, allocations: 334.5 kB / 0.7399 GB, free: 77.61 MB / 0.4985 GB
Notification: Performance of FunctionAlias: time 2.682e-05/0.002518, allocations: 17.81 kB / 0.7399 GB, free: 77.6 MB / 0.4985 GB
Notification: Performance of Early Inline: time 9.481e-05/0.002613, allocations: 168.7 kB / 0.74 GB, free: 77.46 MB / 0.4985 GB
Notification: Performance of Simplify 1: time 5.208e-05/0.002665, allocations: 64.95 kB / 0.7401 GB, free: 77.39 MB / 0.4985 GB
Notification: Performance of Alias: time 3.475e-05/0.0027, allocations: 77.34 kB / 0.7402 GB, free: 77.27 MB / 0.4985 GB
Notification: Performance of Simplify 2: time 3.477e-05/0.002734, allocations: 64.42 kB / 0.7402 GB, free: 77.2 MB / 0.4985 GB
Notification: Performance of Remove Stream: time 2.652e-05/0.002761, allocations: 66.28 kB / 0.7403 GB, free: 77.11 MB / 0.4985 GB
Notification: Performance of Detect States: time 9.755e-05/0.002858, allocations: 99.61 kB / 0.7404 GB, free: 76.98 MB / 0.4985 GB
Notification: Performance of Events: time 1.479e-05/0.002873, allocations: 17.94 kB / 0.7404 GB, free: 76.96 MB / 0.4985 GB
Notification: Performance of Partitioning: time 5.959e-05/0.002933, allocations: 41.44 kB / 0.7405 GB, free: 76.93 MB / 0.4985 GB
Notification: Performance of Causalize: time 0.0201/0.02303, allocations: 30.65 MB / 0.7704 GB, free: 47.75 MB / 0.4985 GB
Notification: Performance of After Index Reduction Inline: time 7.821e-05/0.02311, allocations: 115.9 kB / 0.7705 GB, free: 47.64 MB / 0.4985 GB
Notification: Performance of Simplify: time 8.253e-05/0.02319, allocations: 116.7 kB / 0.7706 GB, free: 47.47 MB / 0.4985 GB
Notification: Performance of Inline: time 8.318e-05/0.02328, allocations: 183.8 kB / 0.7708 GB, free: 47.29 MB / 0.4985 GB
Notification: Performance of Partitioning: time 8.456e-06/0.02328, allocations: 24.05 kB / 0.7708 GB, free: 47.26 MB / 0.4985 GB
Notification: Performance of Cleanup: time 1.594e-05/0.0233, allocations: 19.97 kB / 0.7708 GB, free: 47.24 MB / 0.4985 GB
Notification: Performance of Causalize: time 0.06495/0.08825, allocations: 80.72 MB / 0.8497 GB, free: 0 / 0.5298 GB
Notification: Performance of Tearing: time 1.218e-05/0.08826, allocations: 1.5 kB / 0.8497 GB, free: 0 / 0.5298 GB
Notification: Performance of Initialization: time 7.82e-07/0.08826, allocations: 0 / 0.8497 GB, free: 0 / 0.5298 GB
Notification: Performance of Remove Dummies: time 4.769e-06/0.08826, allocations: 0 / 0.8497 GB, free: 0 / 0.5298 GB
Notification: Performance of Tearing: time 1.483e-05/0.08828, allocations: 4.047 kB / 0.8497 GB, free: 15.99 MB / 0.5454 GB
Notification: Performance of Categorize: time 1.058e-05/0.08829, allocations: 7.938 kB / 0.8497 GB, free: 15.99 MB / 0.5454 GB
Notification: Performance of Solve: time 0.0001872/0.08848, allocations: 63.94 kB / 0.8497 GB, free: 15.93 MB / 0.5454 GB
Notification: Performance of Jacobian: time 1.267e-05/0.08849, allocations: 4.062 kB / 0.8497 GB, free: 15.92 MB / 0.5454 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 1
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 0
 * 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: ............................. 6400 (2) {x, v}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 0 (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: ........... 2 (scalar:2, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 4 (scalar:4, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 4 (resizable: 4, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 4.225e-05/0.08853, allocations: 18.22 kB / 0.8498 GB, free: 15.91 MB / 0.5454 GB
Notification: Performance of SimCode: time 0.2441/0.3327, allocations: 64.4 MB / 0.9126 GB, free: 139.4 MB / 0.5923 GB
Notification: Performance of Templates: time 0.0635/0.3961, allocations: 20.74 MB / 0.9329 GB, free: 128 MB / 0.5923 GB
"
[Timeout remaining time 400]
make -j16 -f LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.makefile [Timeout 400]
(rm -f LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.pipe ; mkfifo LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.pipe ; head -c 1048576 < LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.pipe >> ../files/LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.sim & ./LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200  -s=gbode -gbm=dopri45 -abortSlowSimulation -alarm=400 -lv LOG_STATS > LargeTestSuite_NB_LargeTestSuite.Mechanical.HarmonicOscillator.HarmonicOscillator_N_3200.pipe 2>&1) [Timeout 400]
[Calling sys.exit(0), Time elapsed: 3.667314425110817]
Failed to read output from testmodel.py, exit status != 0:
0.4019941221922636 0.41006149899999994 0.40615555299999995
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f792b165720>