Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.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.001825/0.001825, allocations: 116.1 kB / 21.1 MB, free: 0.7656 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.001858/0.001858, allocations: 208.7 kB / 24.38 MB, free: 4.172 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.4967/0.4967, allocations: 233.3 MB / 260.8 MB, free: 14.88 MB / 222.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.6292/0.6292, allocations: 120.7 MB / 438 MB, free: 1.82 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.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_640,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="E.1.|E.2.|E.3.|E.640.|M.1.|M.2.|M.3.|M.640.|der.E.1..|der.E.2..|der.E.3..|der.E.640..|der.M.1..|der.M.2..|der.M.3..|der.M.640..|der.h.1..|der.h.2..|der.h.3..|der.h.640..|der.p.1..|der.p.2..|der.p.3..|der.p.640..|der.rho.1..|der.rho.2..|der.rho.3..|der.rho.640..|h.1.|h.2.|h.3.|h.639.|h.640.|h_in.1.|h_in.2.|h_in.3.|h_in.640.|h_out.1.|h_out.2.|h_out.3.|h_out.640.|p.1.|p.2.|p.3.|p.640.|rho.1.|rho.2.|rho.3.|rho.640.|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.3..T|state.3..d|state.3..h|state.3..p|state.640..T|state.640..d|state.640..h|state.640..p|time|time|w_in.1.|w_in.2.|w_in.3.|w_in.640.|w_out.1.|w_out.2.|w_out.3.|w_out.639.|w_out.640.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640")
translateModel(ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="E.1.|E.2.|E.3.|E.640.|M.1.|M.2.|M.3.|M.640.|der.E.1..|der.E.2..|der.E.3..|der.E.640..|der.M.1..|der.M.2..|der.M.3..|der.M.640..|der.h.1..|der.h.2..|der.h.3..|der.h.640..|der.p.1..|der.p.2..|der.p.3..|der.p.640..|der.rho.1..|der.rho.2..|der.rho.3..|der.rho.640..|h.1.|h.2.|h.3.|h.639.|h.640.|h_in.1.|h_in.2.|h_in.3.|h_in.640.|h_out.1.|h_out.2.|h_out.3.|h_out.640.|p.1.|p.2.|p.3.|p.640.|rho.1.|rho.2.|rho.3.|rho.640.|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.3..T|state.3..d|state.3..h|state.3..p|state.640..T|state.640..d|state.640..h|state.640..p|time|time|w_in.1.|w_in.2.|w_in.3.|w_in.640.|w_out.1.|w_out.2.|w_out.3.|w_out.639.|w_out.640.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640") [Timeout 400]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.494e-05/1.494e-05, allocations: 2.281 kB / 0.6105 GB, free: 43.47 MB / 478.2 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640): time 0.009789/0.009804, allocations: 12.71 MB / 0.6229 GB, free: 33.37 MB / 478.2 MB
Notification: Performance of NFInst.instExpressions: time 0.005507/0.01531, allocations: 7.785 MB / 0.6306 GB, free: 26.34 MB / 478.2 MB
Notification: Performance of NFInst.updateImplicitVariability: time 6.091e-05/0.01537, allocations: 0 / 0.6306 GB, free: 26.34 MB / 478.2 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001462/0.01552, allocations: 39.75 kB / 0.6306 GB, free: 26.3 MB / 478.2 MB
Notification: Performance of NFTyping.typeBindings: time 0.005371/0.02089, allocations: 3.215 MB / 0.6337 GB, free: 23.09 MB / 478.2 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0003782/0.02127, allocations: 214.9 kB / 0.6339 GB, free: 22.88 MB / 478.2 MB
Notification: Performance of NFFlatten.flatten: time 0.0001537/0.02142, allocations: 203.3 kB / 0.6341 GB, free: 22.68 MB / 478.2 MB
Notification: Performance of NFFlatten.resolveArrayConnections: time 2.919e-05/0.02145, allocations: 7.984 kB / 0.6341 GB, free: 22.68 MB / 478.2 MB
Notification: Performance of NFEvalConstants.evaluate: time 5.644e-05/0.02151, allocations: 87.73 kB / 0.6342 GB, free: 22.59 MB / 478.2 MB
Notification: Performance of NFSimplifyModel.simplify: time 8.769e-05/0.02159, allocations: 123.6 kB / 0.6343 GB, free: 22.47 MB / 478.2 MB
Notification: Performance of NFPackage.collectConstants: time 1.452e-05/0.02161, allocations: 8 kB / 0.6343 GB, free: 22.46 MB / 478.2 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004271/0.02588, allocations: 5.479 MB / 0.6397 GB, free: 16.98 MB / 478.2 MB
Notification: Performance of combineBinaries: time 0.0001579/0.02604, allocations: 341.6 kB / 0.64 GB, free: 16.64 MB / 478.2 MB
Notification: Performance of replaceArrayConstructors: time 9.218e-05/0.02613, allocations: 214.2 kB / 0.6402 GB, free: 16.43 MB / 478.2 MB
Notification: Performance of NFVerifyModel.verify: time 2.096e-05/0.02615, allocations: 11.94 kB / 0.6402 GB, free: 16.42 MB / 478.2 MB
Notification: Performance of FrontEnd: time 7.564e-06/0.02616, allocations: 4 kB / 0.6402 GB, free: 16.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: 8966 (19)
 * Number of variables: 8966 (20)
Notification: Performance of Bindings: time 0.001275/0.02743, allocations: 2.049 MB / 0.6422 GB, free: 14.24 MB / 478.2 MB
Notification: Performance of FunctionAlias: time 5.247e-05/0.02749, allocations: 81.23 kB / 0.6423 GB, free: 14.14 MB / 478.2 MB
Notification: Performance of Early Inline: time 0.0003918/0.02788, allocations: 0.726 MB / 0.643 GB, free: 13.39 MB / 478.2 MB
Notification: Performance of Simplify 1: time 7.66e-05/0.02795, allocations: 120.5 kB / 0.6431 GB, free: 13.23 MB / 478.2 MB
Notification: Performance of Alias: time 0.0001039/0.02806, allocations: 212.4 kB / 0.6433 GB, free: 12.97 MB / 478.2 MB
Notification: Performance of Simplify 2: time 6.763e-05/0.02812, allocations: 128.5 kB / 0.6435 GB, free: 12.8 MB / 478.2 MB
Notification: Performance of Remove Stream: time 3.624e-05/0.02816, allocations: 68.39 kB / 0.6435 GB, free: 12.7 MB / 478.2 MB
Notification: Performance of Detect States: time 0.0001129/0.02827, allocations: 164.6 kB / 0.6437 GB, free: 12.49 MB / 478.2 MB
Notification: Performance of Events: time 5.16e-05/0.02833, allocations: 39.83 kB / 0.6437 GB, free: 12.45 MB / 478.2 MB
Notification: Performance of Partitioning: time 0.0001203/0.02845, allocations: 164.1 kB / 0.6439 GB, free: 12.27 MB / 478.2 MB
Notification: Performance of Causalize: time 0.0006767/0.02912, allocations: 0.7595 MB / 0.6446 GB, free: 11.52 MB / 478.2 MB
Notification: Performance of After Index Reduction Inline: time 0.0002664/0.02939, allocations: 0.6084 MB / 0.6452 GB, free: 10.91 MB / 478.2 MB
Notification: Performance of Simplify: time 0.0002853/0.02967, allocations: 302.2 kB / 0.6455 GB, free: 10.55 MB / 478.2 MB
Notification: Performance of Inline: time 0.0005005/0.03017, allocations: 1.039 MB / 0.6465 GB, free: 9.5 MB / 478.2 MB
Notification: Performance of Partitioning: time 1.734e-05/0.03019, allocations: 21.44 kB / 0.6465 GB, free: 9.473 MB / 478.2 MB
Notification: Performance of Cleanup: time 5.914e-05/0.03025, allocations: 103.9 kB / 0.6466 GB, free: 9.371 MB / 478.2 MB
Notification: Performance of Causalize: time 0.000831/0.03108, allocations: 1.046 MB / 0.6477 GB, free: 8.332 MB / 478.2 MB
Notification: Performance of Tearing: time 8.316e-06/0.03109, allocations: 4 kB / 0.6477 GB, free: 8.328 MB / 478.2 MB
Notification: Performance of Initialization: time 2.7e-07/0.03109, allocations: 0 / 0.6477 GB, free: 8.328 MB / 478.2 MB
Notification: Performance of Remove Dummies: time 3.497e-06/0.03109, allocations: 8 kB / 0.6477 GB, free: 8.32 MB / 478.2 MB
Notification: Performance of Tearing: time 0.0005276/0.03162, allocations: 1.202 MB / 0.6488 GB, free: 6.938 MB / 478.2 MB
Notification: Performance of Categorize: time 5.861e-06/0.03163, allocations: 7.938 kB / 0.6489 GB, free: 6.93 MB / 478.2 MB
Notification: Performance of Solve: time 0.0001841/0.03181, allocations: 145.8 kB / 0.649 GB, free: 6.789 MB / 478.2 MB
Notification: Performance of Jacobian: time 0.0005548/0.03237, allocations: 1.411 MB / 0.6504 GB, free: 5.246 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: ............................. 1280 (2) {E, M}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 642 (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.197e-05/0.0324, allocations: 40.48 kB / 0.6504 GB, free: 5.223 MB / 478.2 MB
Notification: Performance of SimCode: time 0.1182/0.1506, allocations: 139.9 MB / 0.787 GB, free: 8.066 MB / 0.6077 GB
Notification: Performance of Templates: time 0.5258/0.6764, allocations: 55.4 MB / 0.8411 GB, free: 120.6 MB / 0.6235 GB
"
[Timeout remaining time 399]
make -j16 -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.makefile [Timeout 400]
(rm -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.pipe ; mkfifo ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.pipe ; head -c 1048576 < ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.pipe >> ../files/ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.sim & ./ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640  -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_NB_resizable_ScalableTestSuite.Thermal.Advection.ScaledExperiments.SteamPipe_N_640.pipe 2>&1) [Timeout 300]
[Calling os._exit(0), Time elapsed: 3.3908519223332405]
Failed to read output from testmodel.py, exit status != 0:
0.6831355579197407 0.698272507 0.6694577629999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ffb7f265720>