Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.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.001628/0.001628, allocations: 104.3 kB / 19.76 MB, free: 1.906 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 1.504/1.504, allocations: 230.7 MB / 253.5 MB, free: 14.44 MB / 206.1 MB
"
[Timeout remaining time 178]
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.001617/0.001617, allocations: 219.5 kB / 310.1 MB, free: 3.012 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo): time 0.6875/0.6875, allocations: 107.2 MB / 473.7 MB, free: 29.82 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/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 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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(OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1")
translateModel(OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.251e-05/2.251e-05, allocations: 2.281 kB / 0.6343 GB, free: 29.46 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1): time 0.009718/0.009741, allocations: 8.68 MB / 0.6428 GB, free: 23.59 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008536/0.01828, allocations: 3.015 MB / 0.6457 GB, free: 21.49 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003334/0.02161, allocations: 32.69 kB / 0.6458 GB, free: 21.48 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00201/0.02362, allocations: 383.4 kB / 0.6461 GB, free: 21.26 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005195/0.02882, allocations: 1.263 MB / 0.6474 GB, free: 20.43 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003186/0.032, allocations: 0.9868 MB / 0.6483 GB, free: 19.91 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005459/0.03746, allocations: 3.403 MB / 0.6517 GB, free: 18.24 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00139/0.03885, allocations: 393.5 kB / 0.652 GB, free: 18 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002647/0.0415, allocations: 1.262 MB / 0.6533 GB, free: 17.27 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002349/0.04385, allocations: 1.236 MB / 0.6545 GB, free: 16.41 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001179/0.04503, allocations: 227.9 kB / 0.6547 GB, free: 16.41 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00188/0.04691, allocations: 452.3 kB / 0.6551 GB, free: 16.31 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.004967/0.05188, allocations: 5.374 MB / 0.6604 GB, free: 12.17 MB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 0.002279/0.05415, allocations: 3.157 MB / 0.6635 GB, free: 9.516 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0009579/0.05511, allocations: 143.9 kB / 0.6636 GB, free: 9.375 MB / 446.1 MB
Notification: Performance of FrontEnd: time 0.0006294/0.05574, allocations: 71.62 kB / 0.6637 GB, free: 9.305 MB / 446.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 330 (316)
 * Number of variables: 330 (330)
Notification: Performance of [SIM] Bindings: time 0.009758/0.0655, allocations: 11.37 MB / 0.6748 GB, free: 13.56 MB / 462.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.002719/0.06822, allocations: 1.436 MB / 0.6762 GB, free: 12.07 MB / 462.1 MB
Notification: Performance of [SIM] Early Inline: time 0.01302/0.08124, allocations: 9.599 MB / 0.6855 GB, free: 2.414 MB / 462.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.003165/0.0844, allocations: 1.267 MB / 0.6868 GB, free: 1.043 MB / 462.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.01381/0.09821, allocations: 8.083 MB / 0.6947 GB, free: 8.121 MB / 478.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.002027/0.1002, allocations: 1.093 MB / 0.6957 GB, free: 6.945 MB / 478.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.000824/0.1011, allocations: 0.535 MB / 0.6963 GB, free: 6.371 MB / 478.1 MB
Notification: Performance of [SIM] Detect States: time 0.001892/0.103, allocations: 1.487 MB / 0.6977 GB, free: 4.82 MB / 478.1 MB
Notification: Performance of [SIM] Events: time 0.001093/0.104, allocations: 0.6174 MB / 0.6983 GB, free: 4.207 MB / 478.1 MB
Notification: Performance of [SIM] Partitioning: time 0.003094/0.1071, allocations: 2.338 MB / 0.7006 GB, free: 1.828 MB / 478.1 MB
Notification: Performance of [SIM] Causalize: time 0.007401/0.1145, allocations: 4.186 MB / 0.7047 GB, free: 13.57 MB / 494.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.006244/0.1208, allocations: 4.898 MB / 0.7095 GB, free: 8.664 MB / 494.1 MB
Notification: Performance of [INI] Simplify: time 0.009959/0.1307, allocations: 4.551 MB / 0.7139 GB, free: 3.91 MB / 494.1 MB
Notification: Performance of [INI] Inline: time 0.01587/0.1466, allocations: 10.74 MB / 0.7244 GB, free: 9.141 MB / 0.4981 GB
Notification: Performance of [INI] Partitioning: time 0.0007816/0.1474, allocations: 142.5 kB / 0.7245 GB, free: 8.977 MB / 0.4981 GB
Notification: Performance of [INI] Cleanup: time 0.00373/0.1511, allocations: 2.118 MB / 0.7266 GB, free: 6.844 MB / 0.4981 GB
Notification: Performance of [INI] Causalize: time 0.03555/0.1867, allocations: 17.99 MB / 0.7442 GB, free: 4.594 MB / 0.5137 GB
Notification: Performance of [INI] Tearing: time 0.00732/0.194, allocations: 5.098 MB / 0.7492 GB, free: 15.48 MB / 0.5294 GB
Notification: Performance of [SIM] Initialization: time 2.956e-06/0.194, allocations: 4 kB / 0.7492 GB, free: 15.48 MB / 0.5294 GB
Notification: Performance of [SIM] DAE-Mode: time 0.004125/0.1981, allocations: 2.577 MB / 0.7517 GB, free: 12.88 MB / 0.5294 GB
Notification: Performance of [SIM] Remove Dummies: time 1.639e-05/0.1981, allocations: 5.312 kB / 0.7517 GB, free: 12.88 MB / 0.5294 GB
Notification: Performance of [SIM] Tearing: time 0.002466/0.2006, allocations: 1.443 MB / 0.7531 GB, free: 11.43 MB / 0.5294 GB
Notification: Performance of [SIM] Categorize: time 3.497e-05/0.2006, allocations: 15.98 kB / 0.7531 GB, free: 11.41 MB / 0.5294 GB
Notification: Performance of [SIM] Solve: time 0.01767/0.2183, allocations: 9.494 MB / 0.7624 GB, free: 1.902 MB / 0.5294 GB
Notification: Performance of [SIM] Jacobian: time 0.02023/0.2385, allocations: 12.56 MB / 0.7746 GB, free: 5.5 MB / 0.545 GB
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: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 19 (19) {gENCLS.delta, gENCLS.omega, gENCLS.eq, gENROU.w, gENROU.ANGLE, iEEET1.derivativeLag.x, iEEET1.simpleLagLim.state, gENROU.EFD, iEEET1.TransducerDelay.state, iEEEG1.imLeadLag.TF.x_scaled, iEEEG1.imSimpleLag.state, iEEEG1.imSimpleLag1.state, iEEEG1.imSimpleLag2.state, iEEEG1.imSimpleLag3.state, iEEEG1.limIntegrator.y, gENROU.Epd, gENROU.Epq, gENROU.PSIkd, gENROU.PSIkq}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 31 (31) {$SEV_10, $SEV_9, $SEV_8, $SEV_7, $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: ........... 140 (scalar:139, 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: ........... 363 (scalar:362, array:1, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:1)
 * 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 (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 363 (scalar:362, array:1, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:1)
 * 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.0002873/0.2388, allocations: 157.9 kB / 0.7748 GB, free: 5.355 MB / 0.545 GB
Notification: Performance of SimCode: time 0.01838/0.2572, allocations: 10.49 MB / 0.785 GB, free: 10.58 MB / 0.5606 GB
Notification: Performance of Templates: time 0.3921/0.6493, allocations: 33.67 MB / 0.8179 GB, free: 115.7 MB / 0.5762 GB
"
[Timeout remaining time 659]
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.makefile [Timeout 660]
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEEEG1.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 7.517217173008248]
Failed to read output from testmodel.py, exit status != 0:
0.6584734439966269 0.6724642909999999 0.613914156
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe021416fb0>