Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.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.001815/0.001815, allocations: 116.1 kB / 21.1 MB, free: 0.7891 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.001856/0.001856, allocations: 219.3 kB / 24.39 MB, free: 4.195 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.5327/0.5327, allocations: 233.3 MB / 260.9 MB, free: 14.84 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.6702/0.6702, allocations: 120.7 MB / 438 MB, free: 1.859 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.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160,tolerance=1e-08,outputFormat="mat",numberOfIntervals=1999,variableFilter="cur.160.|cur.1.|cur.2.|cur.3.|cur.4.|cur.5.|der.cur.1..|der.cur.2..|der.cur.3..|der.cur.4..|der.cur.5..|der.vol.160..|der.vol.1..|der.vol.2..|der.vol.3..|der.vol.4..|der.vol.5..|time|time|vol.160.|vol.1.|vol.2.|vol.3.|vol.4.|vol.5.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160")
translateModel(ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160,tolerance=1e-08,outputFormat="mat",numberOfIntervals=1999,variableFilter="cur.160.|cur.1.|cur.2.|cur.3.|cur.4.|cur.5.|der.cur.1..|der.cur.2..|der.cur.3..|der.cur.4..|der.cur.5..|der.vol.160..|der.vol.1..|der.vol.2..|der.vol.3..|der.vol.4..|der.vol.5..|time|time|vol.160.|vol.1.|vol.2.|vol.3.|vol.4.|vol.5.",fileNamePrefix="ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160") [Timeout 400]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.578e-05/1.578e-05, allocations: 3.406 kB / 0.612 GB, free: 42.51 MB / 478.3 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160): time 0.001546/0.001562, allocations: 1.35 MB / 0.6134 GB, free: 41.43 MB / 478.3 MB
Notification: Performance of NFInst.instExpressions: time 0.0001831/0.001745, allocations: 63.3 kB / 0.6134 GB, free: 41.38 MB / 478.3 MB
Notification: Performance of NFInst.updateImplicitVariability: time 2.352e-05/0.001768, allocations: 1.062 kB / 0.6134 GB, free: 41.38 MB / 478.3 MB
Notification: Performance of NFTyping.typeComponents: time 6.904e-05/0.001837, allocations: 4 kB / 0.6134 GB, free: 41.38 MB / 478.3 MB
Notification: Performance of NFTyping.typeBindings: time 8.114e-05/0.001919, allocations: 23.8 kB / 0.6134 GB, free: 41.36 MB / 478.3 MB
Notification: Performance of NFTyping.typeClassSections: time 9.128e-05/0.00201, allocations: 20.53 kB / 0.6135 GB, free: 41.34 MB / 478.3 MB
Notification: Performance of NFFlatten.flatten: time 0.0001013/0.002111, allocations: 80.31 kB / 0.6135 GB, free: 41.3 MB / 478.3 MB
Notification: Performance of NFFlatten.resolveArrayConnections: time 4.408e-05/0.002155, allocations: 6.547 kB / 0.6135 GB, free: 41.29 MB / 478.3 MB
Notification: Performance of NFEvalConstants.evaluate: time 3.742e-05/0.002193, allocations: 35.42 kB / 0.6136 GB, free: 41.27 MB / 478.3 MB
Notification: Performance of NFSimplifyModel.simplify: time 7.161e-05/0.002264, allocations: 48.25 kB / 0.6136 GB, free: 41.24 MB / 478.3 MB
Notification: Performance of NFPackage.collectConstants: time 1.724e-05/0.002282, allocations: 3.781 kB / 0.6136 GB, free: 41.24 MB / 478.3 MB
Notification: Performance of NFFlatten.collectFunctions: time 1.388e-05/0.002295, allocations: 3.781 kB / 0.6136 GB, free: 41.24 MB / 478.3 MB
Notification: Performance of combineBinaries: time 9.886e-05/0.002394, allocations: 132.9 kB / 0.6138 GB, free: 41.15 MB / 478.3 MB
Notification: Performance of replaceArrayConstructors: time 3.676e-05/0.002431, allocations: 75.22 kB / 0.6138 GB, free: 41.1 MB / 478.3 MB
Notification: Performance of NFVerifyModel.verify: time 2.009e-05/0.002451, allocations: 7.781 kB / 0.6138 GB, free: 41.09 MB / 478.3 MB
Notification: Performance of FrontEnd: time 6.261e-06/0.002457, allocations: 5.266 kB / 0.6138 GB, free: 41.09 MB / 478.3 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 481 (7)
 * Number of variables: 481 (5)
Notification: Performance of Bindings: time 0.0007048/0.003162, allocations: 0.7361 MB / 0.6146 GB, free: 40.46 MB / 478.3 MB
Notification: Performance of FunctionAlias: time 4.125e-05/0.003203, allocations: 50.08 kB / 0.6146 GB, free: 40.41 MB / 478.3 MB
Notification: Performance of Early Inline: time 0.0001442/0.003348, allocations: 263.2 kB / 0.6149 GB, free: 40.21 MB / 478.3 MB
Notification: Performance of Simplify 1: time 5.324e-05/0.003401, allocations: 94.28 kB / 0.6149 GB, free: 40.09 MB / 478.3 MB
Notification: Performance of Alias: time 6.671e-05/0.003468, allocations: 129.8 kB / 0.6151 GB, free: 39.94 MB / 478.3 MB
Notification: Performance of Simplify 2: time 4.627e-05/0.003514, allocations: 90.36 kB / 0.6152 GB, free: 39.82 MB / 478.3 MB
Notification: Performance of Remove Stream: time 2.386e-05/0.003538, allocations: 49.25 kB / 0.6152 GB, free: 39.76 MB / 478.3 MB
Notification: Performance of Detect States: time 0.0001102/0.003648, allocations: 127.5 kB / 0.6153 GB, free: 39.6 MB / 478.3 MB
Notification: Performance of Events: time 3.887e-05/0.003687, allocations: 16.94 kB / 0.6153 GB, free: 39.59 MB / 478.3 MB
Notification: Performance of Partitioning: time 7.32e-05/0.00376, allocations: 69.53 kB / 0.6154 GB, free: 39.54 MB / 478.3 MB
Notification: Performance of Causalize: time 0.0002692/0.004029, allocations: 180.2 kB / 0.6156 GB, free: 39.45 MB / 478.3 MB
Notification: Performance of After Index Reduction Inline: time 0.0001239/0.004153, allocations: 227.2 kB / 0.6158 GB, free: 39.31 MB / 478.3 MB
Notification: Performance of Simplify: time 0.0001848/0.004338, allocations: 191.4 kB / 0.616 GB, free: 39.1 MB / 478.3 MB
Notification: Performance of Inline: time 0.0002037/0.004541, allocations: 348.6 kB / 0.6163 GB, free: 38.87 MB / 478.3 MB
Notification: Performance of Partitioning: time 1.244e-05/0.004554, allocations: 11.91 kB / 0.6163 GB, free: 38.86 MB / 478.3 MB
Notification: Performance of Cleanup: time 3.201e-05/0.004586, allocations: 40.8 kB / 0.6164 GB, free: 38.82 MB / 478.3 MB
Notification: Performance of Causalize: time 0.0004091/0.004995, allocations: 372.4 kB / 0.6167 GB, free: 38.67 MB / 478.3 MB
Notification: Performance of Tearing: time 7.805e-06/0.005003, allocations: 10.22 kB / 0.6167 GB, free: 38.66 MB / 478.3 MB
Notification: Performance of Initialization: time 4.71e-07/0.005003, allocations: 0 / 0.6167 GB, free: 38.66 MB / 478.3 MB
Notification: Performance of Remove Dummies: time 4.759e-06/0.005008, allocations: 5.031 kB / 0.6167 GB, free: 38.66 MB / 478.3 MB
Notification: Performance of Tearing: time 1.432e-06/0.00501, allocations: 1.094 kB / 0.6167 GB, free: 38.66 MB / 478.3 MB
Notification: Performance of Categorize: time 5.02e-06/0.005015, allocations: 1.062 kB / 0.6167 GB, free: 38.66 MB / 478.3 MB
Notification: Performance of Solve: time 0.0001802/0.005195, allocations: 136.5 kB / 0.6169 GB, free: 38.58 MB / 478.3 MB
Notification: Performance of Jacobian: time 0.0001859/0.005381, allocations: 307.6 kB / 0.6172 GB, free: 38.35 MB / 478.3 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: ......... 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: ............................. 320 (3) {vvol, cur_x, vol}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 1 (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: ........... 5 (scalar:5, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 3 (resizable: 3, 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: ........... 12 (scalar:10, array:2, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 3 (resizable: 3, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 2.679e-05/0.005408, allocations: 25.95 kB / 0.6172 GB, free: 38.34 MB / 478.3 MB
Notification: Performance of SimCode: time 0.004849/0.01026, allocations: 9.002 MB / 0.626 GB, free: 30.36 MB / 478.3 MB
Notification: Performance of Templates: time 0.00606/0.01632, allocations: 3.649 MB / 0.6295 GB, free: 26.79 MB / 478.3 MB
"
[Timeout remaining time 400]
make -j16 -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.makefile [Timeout 400]
(rm -f ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.pipe ; mkfifo ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.pipe ; head -c 1048576 < ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.pipe >> ../files/ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.sim & ./ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160  -s=ida -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_NB_resizable_ScalableTestSuite.Electrical.TransmissionLine.ScaledExperiments.TransmissionLineEquations_N_160.pipe 2>&1) [Timeout 300]
[Calling os._exit(0), Time elapsed: 2.6262429375201464]
Failed to read output from testmodel.py, exit status != 0:
0.021490080282092094 0.029322697 0.025088166000000002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f692f265720>