Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.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.001824/0.001824, allocations: 116.1 kB / 21.1 MB, free: 0.7695 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.001839/0.001839, allocations: 216.6 kB / 24.39 MB, free: 4.168 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 0.5354/0.5354, allocations: 233.3 MB / 260.9 MB, free: 128 kB / 206.1 MB
"
[Timeout remaining time 179]
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.641/0.641, allocations: 120.7 MB / 438 MB, free: 4.266 MB / 350.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.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.Thermal.Advection.ScaledExperiments.SteamPipe_N_320,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="E.1.|E.2.|E.320.|E.3.|M.1.|M.2.|M.320.|M.3.|der.E.1..|der.E.2..|der.E.320..|der.E.3..|der.M.1..|der.M.2..|der.M.320..|der.M.3..|der.h.1..|der.h.2..|der.h.320..|der.h.3..|der.p.1..|der.p.2..|der.p.320..|der.p.3..|der.rho.1..|der.rho.2..|der.rho.320..|der.rho.3..|h.1.|h.2.|h.319.|h.320.|h.3.|h_in.1.|h_in.2.|h_in.320.|h_in.3.|h_out.1.|h_out.2.|h_out.320.|h_out.3.|p.1.|p.2.|p.320.|p.3.|rho.1.|rho.2.|rho.320.|rho.3.|state.1..T|state.1..d|state.1..h|state.1..p|state.2..T|state.2..d|state.2..h|state.2..p|state.320..T|state.320..d|state.320..h|state.320..p|state.3..T|state.3..d|state.3..h|state.3..p|time|time|w_in.1.|w_in.2.|w_in.320.|w_in.3.|w_out.1.|w_out.2.|w_out.319.|w_out.320.|w_out.3.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320")
translateModel(ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="E.1.|E.2.|E.320.|E.3.|M.1.|M.2.|M.320.|M.3.|der.E.1..|der.E.2..|der.E.320..|der.E.3..|der.M.1..|der.M.2..|der.M.320..|der.M.3..|der.h.1..|der.h.2..|der.h.320..|der.h.3..|der.p.1..|der.p.2..|der.p.320..|der.p.3..|der.rho.1..|der.rho.2..|der.rho.320..|der.rho.3..|h.1.|h.2.|h.319.|h.320.|h.3.|h_in.1.|h_in.2.|h_in.320.|h_in.3.|h_out.1.|h_out.2.|h_out.320.|h_out.3.|p.1.|p.2.|p.320.|p.3.|rho.1.|rho.2.|rho.320.|rho.3.|state.1..T|state.1..d|state.1..h|state.1..p|state.2..T|state.2..d|state.2..h|state.2..p|state.320..T|state.320..d|state.320..h|state.320..p|state.3..T|state.3..d|state.3..h|state.3..p|time|time|w_in.1.|w_in.2.|w_in.320.|w_in.3.|w_out.1.|w_out.2.|w_out.319.|w_out.320.|w_out.3.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320") [Timeout 400]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.45e-05/1.45e-05, allocations: 2.281 kB / 0.6105 GB, free: 10.94 MB / 446.2 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320): time 0.009889/0.009904, allocations: 12.71 MB / 0.6229 GB, free: 14.17 MB / 462.2 MB
Notification: Performance of NFInst.instExpressions: time 0.008575/0.01848, allocations: 7.793 MB / 0.6306 GB, free: 6.348 MB / 462.2 MB
Notification: Performance of NFInst.updateImplicitVariability: time 5.662e-05/0.01853, allocations: 0 / 0.6306 GB, free: 6.348 MB / 462.2 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001702/0.01871, allocations: 43.73 kB / 0.6306 GB, free: 6.305 MB / 462.2 MB
Notification: Performance of NFTyping.typeBindings: time 0.00635/0.02505, allocations: 3.212 MB / 0.6337 GB, free: 3.098 MB / 462.2 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00047/0.02552, allocations: 210.9 kB / 0.6339 GB, free: 2.891 MB / 462.2 MB
Notification: Performance of NFFlatten.flatten: time 0.0002368/0.02576, allocations: 207.3 kB / 0.6341 GB, free: 2.688 MB / 462.2 MB
Notification: Performance of NFFlatten.resolveArrayConnections: time 3.539e-05/0.0258, allocations: 11.98 kB / 0.6341 GB, free: 2.676 MB / 462.2 MB
Notification: Performance of NFEvalConstants.evaluate: time 9.741e-05/0.02589, allocations: 83.78 kB / 0.6342 GB, free: 2.594 MB / 462.2 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001515/0.02605, allocations: 127.6 kB / 0.6343 GB, free: 2.469 MB / 462.2 MB
Notification: Performance of NFPackage.collectConstants: time 1.755e-05/0.02606, allocations: 8 kB / 0.6344 GB, free: 2.461 MB / 462.2 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006409/0.03247, allocations: 5.479 MB / 0.6397 GB, free: 12.98 MB / 478.2 MB
Notification: Performance of combineBinaries: time 0.0002942/0.03277, allocations: 345.6 kB / 0.64 GB, free: 12.64 MB / 478.2 MB
Notification: Performance of replaceArrayConstructors: time 0.0001758/0.03294, allocations: 218.2 kB / 0.6402 GB, free: 12.43 MB / 478.2 MB
Notification: Performance of NFVerifyModel.verify: time 3.262e-05/0.03298, allocations: 11.94 kB / 0.6403 GB, free: 12.41 MB / 478.2 MB
Notification: Performance of FrontEnd: time 7.654e-06/0.03298, allocations: 0 / 0.6403 GB, free: 12.41 MB / 478.2 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4486 (19)
 * Number of variables: 4486 (20)
Notification: Performance of Bindings: time 0.002264/0.03525, allocations: 2.048 MB / 0.6423 GB, free: 10.24 MB / 478.2 MB
Notification: Performance of FunctionAlias: time 9.55e-05/0.03534, allocations: 81.16 kB / 0.6423 GB, free: 10.14 MB / 478.2 MB
Notification: Performance of Early Inline: time 0.0006902/0.03603, allocations: 0.7221 MB / 0.643 GB, free: 9.395 MB / 478.2 MB
Notification: Performance of Simplify 1: time 0.0001461/0.03618, allocations: 128.5 kB / 0.6432 GB, free: 9.223 MB / 478.2 MB
Notification: Performance of Alias: time 0.0001991/0.03638, allocations: 204.4 kB / 0.6434 GB, free: 8.977 MB / 478.2 MB
Notification: Performance of Simplify 2: time 0.0001357/0.03651, allocations: 124.5 kB / 0.6435 GB, free: 8.805 MB / 478.2 MB
Notification: Performance of Remove Stream: time 7.431e-05/0.03659, allocations: 76.38 kB / 0.6435 GB, free: 8.703 MB / 478.2 MB
Notification: Performance of Detect States: time 0.0001968/0.03678, allocations: 164.6 kB / 0.6437 GB, free: 8.488 MB / 478.2 MB
Notification: Performance of Events: time 6.261e-05/0.03685, allocations: 27.92 kB / 0.6437 GB, free: 8.461 MB / 478.2 MB
Notification: Performance of Partitioning: time 0.0001883/0.03704, allocations: 152.2 kB / 0.6439 GB, free: 8.297 MB / 478.2 MB
Notification: Performance of Causalize: time 0.00102/0.03806, allocations: 0.7711 MB / 0.6446 GB, free: 7.531 MB / 478.2 MB
Notification: Performance of After Index Reduction Inline: time 0.0005226/0.03858, allocations: 0.6162 MB / 0.6452 GB, free: 6.914 MB / 478.2 MB
Notification: Performance of Simplify: time 0.000432/0.03901, allocations: 301.4 kB / 0.6455 GB, free: 6.551 MB / 478.2 MB
Notification: Performance of Inline: time 0.0009107/0.03992, allocations: 1.039 MB / 0.6465 GB, free: 5.504 MB / 478.2 MB
Notification: Performance of Partitioning: time 2.673e-05/0.03995, allocations: 21.44 kB / 0.6466 GB, free: 5.477 MB / 478.2 MB
Notification: Performance of Cleanup: time 8.576e-05/0.04003, allocations: 95.83 kB / 0.6466 GB, free: 5.383 MB / 478.2 MB
Notification: Performance of Causalize: time 0.001222/0.04125, allocations: 1.038 MB / 0.6477 GB, free: 4.344 MB / 478.2 MB
Notification: Performance of Tearing: time 1.304e-05/0.04127, allocations: 12 kB / 0.6477 GB, free: 4.332 MB / 478.2 MB
Notification: Performance of Initialization: time 2.81e-07/0.04127, allocations: 0 / 0.6477 GB, free: 4.332 MB / 478.2 MB
Notification: Performance of Remove Dummies: time 4.689e-06/0.04127, allocations: 3.938 kB / 0.6477 GB, free: 4.328 MB / 478.2 MB
Notification: Performance of Tearing: time 0.0009312/0.0422, allocations: 1.075 MB / 0.6487 GB, free: 3.09 MB / 478.2 MB
Notification: Performance of Categorize: time 5.36e-06/0.04221, allocations: 0 / 0.6487 GB, free: 3.09 MB / 478.2 MB
Notification: Performance of Solve: time 0.0002262/0.04244, allocations: 145.8 kB / 0.6489 GB, free: 2.949 MB / 478.2 MB
Notification: Performance of Jacobian: time 0.0008486/0.04328, allocations: 0.9959 MB / 0.6498 GB, free: 1.871 MB / 478.2 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * 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: ............................. 640 (2) {E, M}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 322 (3) {state.phase, $TEV_1, $TEV_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: ........... 11 (scalar:11, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 12 (resizable: 12, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 3 (linear: 0, nonlinear:3)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 17 (scalar:17, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 16 (resizable: 16, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 3.945e-05/0.04332, allocations: 36.14 kB / 0.6499 GB, free: 1.852 MB / 478.2 MB
Notification: Performance of SimCode: time 0.06421/0.1075, allocations: 73.03 MB / 0.7212 GB, free: 8.031 MB / 0.5452 GB
Notification: Performance of Templates: time 0.4828/0.5903, allocations: 40.03 MB / 0.7603 GB, free: 60.55 MB / 0.5454 GB
"
[Timeout remaining time 399]
make -j16 -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.makefile [Timeout 400]
(rm -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.pipe ; mkfifo ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.pipe ; head -c 1048576 < ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.pipe >> ../files/ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.sim & ./ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320  -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_320.pipe 2>&1) [Timeout 300]
[Calling os._exit(0), Time elapsed: 3.3060067910701036]
Failed to read output from testmodel.py, exit status != 0:
0.5967384222894907 0.610603047 0.574923409
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe22de59720>