Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.conf.json
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.001657/0.001657, allocations: 101.8 kB / 19.6 MB, free: 2.34 MB / 14.72 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 1.204/1.204, allocations: 225.6 MB / 248.2 MB, free: 3.109 MB / 190.1 MB
"
[Timeout remaining time 179]
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.001227/0.001227, allocations: 196.9 kB / 303.6 MB, free: 3.445 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.305/0.305, allocations: 79.71 MB / 438.6 MB, free: 7.051 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/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 Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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)
Running command: translateModel(OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test")
translateModel(OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.675e-05/1.675e-05, allocations: 2.281 kB / 0.5842 GB, free: 7.848 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test): time 0.003628/0.003644, allocations: 3.083 MB / 0.5872 GB, free: 4.746 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001444/0.005088, allocations: 0.9899 MB / 0.5882 GB, free: 3.754 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001069/0.005195, allocations: 4 kB / 0.5882 GB, free: 3.75 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002231/0.005418, allocations: 91.27 kB / 0.5883 GB, free: 3.66 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002909/0.005709, allocations: 174.9 kB / 0.5885 GB, free: 3.488 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0008815/0.00659, allocations: 468 kB / 0.5889 GB, free: 3.031 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0005475/0.007138, allocations: 0.6307 MB / 0.5895 GB, free: 2.398 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001433/0.007281, allocations: 58.55 kB / 0.5896 GB, free: 2.336 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.000253/0.007534, allocations: 255 kB / 0.5898 GB, free: 2.086 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003176/0.007852, allocations: 306.6 kB / 0.5901 GB, free: 1.785 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 5.484e-05/0.007907, allocations: 44 kB / 0.5902 GB, free: 1.742 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001649/0.008072, allocations: 104 kB / 0.5903 GB, free: 1.641 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.000812/0.008884, allocations: 1.142 MB / 0.5914 GB, free: 500 kB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0003948/0.009278, allocations: 0.648 MB / 0.592 GB, free: 15.83 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 6.853e-05/0.009347, allocations: 71.69 kB / 0.5921 GB, free: 15.76 MB / 462.1 MB
Notification: Performance of FrontEnd: time 2.91e-05/0.009376, allocations: 8 kB / 0.5921 GB, free: 15.75 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 65 (61)
 * Number of variables: 65 (65)
Notification: Performance of Bindings: time 0.002093/0.01147, allocations: 2.463 MB / 0.5945 GB, free: 13.14 MB / 462.1 MB
Notification: Performance of FunctionAlias: time 0.0002553/0.01172, allocations: 252.8 kB / 0.5947 GB, free: 12.89 MB / 462.1 MB
Notification: Performance of Early Inline: time 0.002196/0.01392, allocations: 2.56 MB / 0.5972 GB, free: 10.3 MB / 462.1 MB
Notification: Performance of Simplify 1: time 0.0003337/0.01425, allocations: 312.2 kB / 0.5975 GB, free: 9.941 MB / 462.1 MB
Notification: Performance of Alias: time 0.001524/0.01578, allocations: 1.436 MB / 0.5989 GB, free: 8.387 MB / 462.1 MB
Notification: Performance of Simplify 2: time 0.0002828/0.01606, allocations: 274.1 kB / 0.5992 GB, free: 8.07 MB / 462.1 MB
Notification: Performance of Remove Stream: time 0.0001615/0.01622, allocations: 176.2 kB / 0.5994 GB, free: 7.871 MB / 462.1 MB
Notification: Performance of Detect States: time 0.0004162/0.01664, allocations: 455.4 kB / 0.5998 GB, free: 7.375 MB / 462.1 MB
Notification: Performance of Events: time 0.0002014/0.01684, allocations: 172.8 kB / 0.6 GB, free: 7.203 MB / 462.1 MB
Notification: Performance of Partitioning: time 0.0005016/0.01734, allocations: 0.5247 MB / 0.6005 GB, free: 6.672 MB / 462.1 MB
Notification: Performance of Causalize: time 0.001625/0.01897, allocations: 1.406 MB / 0.6018 GB, free: 5.25 MB / 462.1 MB
Notification: Performance of After Index Reduction Inline: time 0.001085/0.02005, allocations: 1.327 MB / 0.6031 GB, free: 3.922 MB / 462.1 MB
Notification: Performance of Simplify: time 0.001334/0.02139, allocations: 1.114 MB / 0.6042 GB, free: 2.738 MB / 462.1 MB
Notification: Performance of Inline: time 0.002122/0.02351, allocations: 2.614 MB / 0.6068 GB, free: 124 kB / 462.1 MB
Notification: Performance of Partitioning: time 6.045e-05/0.02357, allocations: 39.98 kB / 0.6068 GB, free: 72 kB / 462.1 MB
Notification: Performance of Cleanup: time 0.1632/0.1868, allocations: 387.2 kB / 0.6072 GB, free: 53.2 MB / 462.1 MB
Notification: Performance of Causalize: time 0.002852/0.1897, allocations: 2.686 MB / 0.6098 GB, free: 53.07 MB / 462.1 MB
Notification: Performance of Tearing: time 0.001405/0.1911, allocations: 2.041 MB / 0.6118 GB, free: 52.4 MB / 462.1 MB
Notification: Performance of Initialization: time 6.51e-07/0.1911, allocations: 0 / 0.6118 GB, free: 52.4 MB / 462.1 MB
Notification: Performance of Remove Dummies: time 6.332e-06/0.1911, allocations: 0 / 0.6118 GB, free: 52.4 MB / 462.1 MB
Notification: Performance of Tearing: time 0.0008078/0.1919, allocations: 1.396 MB / 0.6132 GB, free: 51.7 MB / 462.1 MB
Notification: Performance of Categorize: time 8.536e-06/0.1919, allocations: 4 kB / 0.6132 GB, free: 51.7 MB / 462.1 MB
Notification: Performance of Solve: time 0.0006523/0.1926, allocations: 0.7365 MB / 0.6139 GB, free: 51.67 MB / 462.1 MB
Notification: Performance of Jacobian: time 0.0004124/0.193, allocations: 0.5694 MB / 0.6144 GB, free: 51.46 MB / 462.1 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: ............................. 5 (5) {motorTypeI.e2r, motorTypeI.e2m, motorTypeI.s, motorTypeI.e1r, motorTypeI.e1m}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 6 (6) {$TEV_5, $TEV_4, $TEV_3, $TEV_2, $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: ........... 41 (scalar:41, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: ... 3 (linear: 0, nonlinear:3)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 78 (scalar:78, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: ... 3 (linear: 0, nonlinear:3)
Notification: Performance of backend: time 3.476e-05/0.193, allocations: 36.03 kB / 0.6145 GB, free: 51.43 MB / 462.1 MB
Notification: Performance of SimCode: time 0.001719/0.1947, allocations: 2.902 MB / 0.6173 GB, free: 50.29 MB / 462.1 MB
Notification: Performance of Templates: time 0.01036/0.2051, allocations: 7.462 MB / 0.6246 GB, free: 49.91 MB / 462.1 MB
"
[Timeout remaining time 660]
make -j1 -f OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.makefile [Timeout 660]
(rm -f OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.pipe ; mkfifo OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.pipe >> ../files/OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.sim & ./OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_OpenIPSL.Tests.Machines.PSAT.InductiveMotorV_SIMBOpenline_Test.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 4.585403357632458]
Failed to read output from testmodel.py, exit status != 0:
0.21165007818490267 0.21965277199999994 0.20838733599999995
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f6825df5780>