Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.07827/0.07827, allocations: 12.37 MB / 32.03 MB, free: 6.406 MB / 26.18 MB
"
[Timeout remaining time 180]
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.001252/0.001252, allocations: 109 kB / 38.06 MB, free: 1.086 MB / 26.18 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.345/1.345, allocations: 207.7 MB / 251.7 MB, free: 7.27 MB / 190.1 MB
"
[Timeout remaining time 179]
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.001541/0.001541, allocations: 216.3 kB / 307 MB, free: 268 kB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.31/0.31, allocations: 79.73 MB / 441.8 MB, free: 12.25 MB / 318.1 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/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 Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo)
Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.ES.SEXS,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS")
translateModel(OpenIPSL.Tests.Controls.PSSE.ES.SEXS,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.484e-05/1.484e-05, allocations: 5.781 kB / 0.5888 GB, free: 7.027 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.ES.SEXS): time 0.008665/0.00868, allocations: 7.084 MB / 0.5957 GB, free: 15.89 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.005142/0.01382, allocations: 2.385 MB / 0.598 GB, free: 13.5 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000531/0.01435, allocations: 15.94 kB / 0.598 GB, free: 13.48 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007786/0.01513, allocations: 313.4 kB / 0.5983 GB, free: 13.18 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002802/0.01793, allocations: 1.216 MB / 0.5995 GB, free: 11.96 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001391/0.01933, allocations: 0.6773 MB / 0.6002 GB, free: 11.29 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002859/0.02218, allocations: 2.736 MB / 0.6028 GB, free: 8.547 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004518/0.02264, allocations: 234.8 kB / 0.6031 GB, free: 8.293 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001043/0.02368, allocations: 0.965 MB / 0.604 GB, free: 7.324 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0013/0.02498, allocations: 1.147 MB / 0.6051 GB, free: 6.172 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002449/0.02522, allocations: 164 kB / 0.6053 GB, free: 6.012 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006553/0.02588, allocations: 351.8 kB / 0.6056 GB, free: 5.668 MB / 414.1 MB
Notification: Performance of combineBinaries: time 0.003494/0.02937, allocations: 4.281 MB / 0.6098 GB, free: 1.348 MB / 414.1 MB
Notification: Performance of replaceArrayConstructors: time 0.001873/0.03125, allocations: 2.414 MB / 0.6122 GB, free: 14.9 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0002313/0.03148, allocations: 108 kB / 0.6123 GB, free: 14.79 MB / 430.1 MB
Notification: Performance of FrontEnd: time 0.0002008/0.03168, allocations: 47.81 kB / 0.6123 GB, free: 14.75 MB / 430.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 234 (220)
 * Number of variables: 234 (234)
Notification: Performance of [SIM] Bindings: time 0.00819/0.03987, allocations: 8.807 MB / 0.6209 GB, free: 5.668 MB / 430.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001245/0.04111, allocations: 1.024 MB / 0.6219 GB, free: 4.582 MB / 430.1 MB
Notification: Performance of [SIM] Early Inline: time 0.008193/0.04931, allocations: 8.202 MB / 0.6299 GB, free: 12.29 MB / 446.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001698/0.051, allocations: 1.084 MB / 0.631 GB, free: 11.1 MB / 446.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.007624/0.05863, allocations: 5.807 MB / 0.6366 GB, free: 4.773 MB / 446.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001367/0.06, allocations: 0.9892 MB / 0.6376 GB, free: 3.703 MB / 446.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.000494/0.06049, allocations: 463.9 kB / 0.6381 GB, free: 3.211 MB / 446.1 MB
Notification: Performance of [SIM] Detect States: time 0.001239/0.06173, allocations: 1.232 MB / 0.6393 GB, free: 1.914 MB / 446.1 MB
Notification: Performance of [SIM] Events: time 0.0007641/0.06249, allocations: 0.5619 MB / 0.6398 GB, free: 1.355 MB / 446.1 MB
Notification: Performance of [SIM] Partitioning: time 0.2064/0.2689, allocations: 2.013 MB / 0.6418 GB, free: 42.77 MB / 446.1 MB
Notification: Performance of [SIM] Causalize: time 0.004918/0.2738, allocations: 3.587 MB / 0.6453 GB, free: 42.57 MB / 446.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.003276/0.2771, allocations: 4.144 MB / 0.6493 GB, free: 42.45 MB / 446.1 MB
Notification: Performance of [INI] Simplify: time 0.00606/0.2831, allocations: 4.157 MB / 0.6534 GB, free: 41 MB / 446.1 MB
Notification: Performance of [INI] Inline: time 0.007154/0.2903, allocations: 9.675 MB / 0.6628 GB, free: 36.05 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.0002733/0.2905, allocations: 114.2 kB / 0.6629 GB, free: 35.97 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.0008085/0.2913, allocations: 1.225 MB / 0.6641 GB, free: 35.3 MB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.01009/0.3014, allocations: 7.467 MB / 0.6714 GB, free: 33.22 MB / 446.1 MB
Notification: Performance of [INI] Tearing: time 0.002645/0.3041, allocations: 2.473 MB / 0.6738 GB, free: 32.07 MB / 446.1 MB
Notification: Performance of [SIM] Initialization: time 1.583e-06/0.3041, allocations: 0 / 0.6738 GB, free: 32.07 MB / 446.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.002311/0.3064, allocations: 2.322 MB / 0.6761 GB, free: 30.98 MB / 446.1 MB
Notification: Performance of [SIM] Remove Dummies: time 8.817e-06/0.3064, allocations: 4.938 kB / 0.6761 GB, free: 30.97 MB / 446.1 MB
Notification: Performance of [SIM] Tearing: time 0.001305/0.3077, allocations: 1.372 MB / 0.6775 GB, free: 30.32 MB / 446.1 MB
Notification: Performance of [SIM] Categorize: time 1.732e-05/0.3077, allocations: 10.66 kB / 0.6775 GB, free: 30.32 MB / 446.1 MB
Notification: Performance of [SIM] Solve: time 0.006596/0.3143, allocations: 7.703 MB / 0.685 GB, free: 25.98 MB / 446.1 MB
Notification: Performance of [SIM] Jacobian: time 0.01024/0.3246, allocations: 12.45 MB / 0.6971 GB, free: 13.93 MB / 446.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 1
 * 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: ............................. 11 (11) {gENCLS.delta, gENCLS.omega, gENCLS.eq, gENROU.SPEED, gENROU.ANGLE, sEXS.simpleLagLim.state, sEXS.leadLag.TF.x_scaled, gENROU.Epd, gENROU.Epq, gENROU.PSIkd, gENROU.PSIkq}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 27 (27) {$SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_19, $TEV_18, $TEV_17, $TEV_16, $TEV_15, $TEV_14, $TEV_13, $TEV_12, $TEV_11, $TEV_10, $TEV_9, $TEV_8, $TEV_7, $TEV_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: ........... 98 (scalar:97, array:1, 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: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 263 (scalar:262, array:1, 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: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0001146/0.3247, allocations: 83.19 kB / 0.6972 GB, free: 13.86 MB / 446.1 MB
Notification: Performance of SimCode: time 0.006676/0.3314, allocations: 8.145 MB / 0.7052 GB, free: 5.562 MB / 446.1 MB
Notification: Performance of Templates: time 0.04337/0.3747, allocations: 28.48 MB / 0.733 GB, free: 9.168 MB / 478.1 MB
"
[Timeout remaining time 660]
make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.makefile [Timeout 660]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.sim & ./OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.SEXS.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.844696225016378]
Failed to read output from testmodel.py, exit status != 0:
0.38279312301892787 0.39682946100000005 0.362239466
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0cd03eefb0>