Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.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.001802/0.001802, 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.517/1.517, allocations: 230.6 MB / 253.5 MB, free: 14.26 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.001704/0.001704, allocations: 216.9 kB / 310.1 MB, free: 3.051 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.5033/0.5033, allocations: 79.75 MB / 446.3 MB, free: 40.32 MB / 350.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.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.Machines.PSSE.GENSAL,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL")
translateModel(OpenIPSL.Tests.Machines.PSSE.GENSAL,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.676e-05/2.676e-05, allocations: 2.938 kB / 0.5941 GB, free: 38.5 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Machines.PSSE.GENSAL): time 0.006253/0.00628, allocations: 6.12 MB / 0.6001 GB, free: 35.31 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.004508/0.01079, allocations: 2.143 MB / 0.6022 GB, free: 33.86 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008907/0.01168, allocations: 12.75 kB / 0.6022 GB, free: 33.86 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0006342/0.01231, allocations: 272.1 kB / 0.6025 GB, free: 33.72 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002715/0.01503, allocations: 1.169 MB / 0.6036 GB, free: 33.01 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001329/0.01636, allocations: 0.5709 MB / 0.6042 GB, free: 32.75 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002507/0.01886, allocations: 2.305 MB / 0.6064 GB, free: 31.69 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003625/0.01923, allocations: 182.5 kB / 0.6066 GB, free: 31.59 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0007723/0.02, allocations: 0.8212 MB / 0.6074 GB, free: 31.21 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008757/0.02087, allocations: 1.011 MB / 0.6084 GB, free: 30.8 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001682/0.02104, allocations: 122.1 kB / 0.6085 GB, free: 30.8 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005809/0.02162, allocations: 306.9 kB / 0.6088 GB, free: 30.76 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.001889/0.02351, allocations: 3.69 MB / 0.6124 GB, free: 28.38 MB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0007506/0.02426, allocations: 2.089 MB / 0.6144 GB, free: 26.92 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001507/0.02441, allocations: 90.94 kB / 0.6145 GB, free: 26.92 MB / 446.1 MB
Notification: Performance of FrontEnd: time 0.0001292/0.02454, allocations: 36.88 kB / 0.6146 GB, free: 26.91 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: 198 (184)
 * Number of variables: 198 (198)
Notification: Performance of [SIM] Bindings: time 0.004273/0.02882, allocations: 7.57 MB / 0.622 GB, free: 21.89 MB / 446.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0007432/0.02956, allocations: 0.8544 MB / 0.6228 GB, free: 21.41 MB / 446.1 MB
Notification: Performance of [SIM] Early Inline: time 0.004919/0.03448, allocations: 7.433 MB / 0.6301 GB, free: 17.63 MB / 446.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001055/0.03553, allocations: 0.9427 MB / 0.631 GB, free: 17.26 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.004601/0.04013, allocations: 4.92 MB / 0.6358 GB, free: 14.28 MB / 446.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.000904/0.04104, allocations: 0.8898 MB / 0.6366 GB, free: 13.92 MB / 446.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0003119/0.04135, allocations: 428.8 kB / 0.6371 GB, free: 13.64 MB / 446.1 MB
Notification: Performance of [SIM] Detect States: time 0.0007084/0.04206, allocations: 1.067 MB / 0.6381 GB, free: 12.96 MB / 446.1 MB
Notification: Performance of [SIM] Events: time 0.00056/0.04262, allocations: 0.535 MB / 0.6386 GB, free: 12.69 MB / 446.1 MB
Notification: Performance of [SIM] Partitioning: time 0.001413/0.04403, allocations: 1.815 MB / 0.6404 GB, free: 11.91 MB / 446.1 MB
Notification: Performance of [SIM] Causalize: time 0.004459/0.04849, allocations: 3.336 MB / 0.6436 GB, free: 11 MB / 446.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002671/0.05116, allocations: 3.681 MB / 0.6472 GB, free: 9.035 MB / 446.1 MB
Notification: Performance of [INI] Simplify: time 0.005504/0.05666, allocations: 3.474 MB / 0.6506 GB, free: 7.344 MB / 446.1 MB
Notification: Performance of [INI] Inline: time 0.008355/0.06502, allocations: 8.967 MB / 0.6594 GB, free: 2.113 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.0003015/0.06532, allocations: 104.5 kB / 0.6595 GB, free: 2.039 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.0008025/0.06612, allocations: 1.08 MB / 0.6605 GB, free: 1.125 MB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.009277/0.0754, allocations: 6.329 MB / 0.6667 GB, free: 14.68 MB / 462.1 MB
Notification: Performance of [INI] Tearing: time 0.002987/0.07839, allocations: 2.262 MB / 0.6689 GB, free: 12.43 MB / 462.1 MB
Notification: Performance of [SIM] Initialization: time 3.377e-06/0.07839, allocations: 4 kB / 0.6689 GB, free: 12.42 MB / 462.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.00294/0.08133, allocations: 2.172 MB / 0.6711 GB, free: 10.23 MB / 462.1 MB
Notification: Performance of [SIM] Remove Dummies: time 8.617e-06/0.08134, allocations: 0.6562 kB / 0.6711 GB, free: 10.23 MB / 462.1 MB
Notification: Performance of [SIM] Tearing: time 0.001691/0.08303, allocations: 1.334 MB / 0.6724 GB, free: 8.895 MB / 462.1 MB
Notification: Performance of [SIM] Categorize: time 1.672e-05/0.08305, allocations: 8 kB / 0.6724 GB, free: 8.887 MB / 462.1 MB
Notification: Performance of [SIM] Solve: time 0.008698/0.09175, allocations: 6.686 MB / 0.6789 GB, free: 2.188 MB / 462.1 MB
Notification: Performance of [SIM] Jacobian: time 0.01553/0.1073, allocations: 11.76 MB / 0.6904 GB, free: 6.59 MB / 478.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: ............................. 8 (8) {gENCLS.delta, gENCLS.omega, gENCLS.eq, gENSAL.SPEED, gENSAL.ANGLE, gENSAL.Epq, gENSAL.PSIkd, gENSAL.PSIppq}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 23 (23) {$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: ........... 81 (scalar:81, 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: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 209 (scalar:209, 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: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0001283/0.1074, allocations: 70.42 kB / 0.6905 GB, free: 6.523 MB / 478.1 MB
Notification: Performance of SimCode: time 0.009209/0.1166, allocations: 6.973 MB / 0.6973 GB, free: 15.37 MB / 494.1 MB
Notification: Performance of Templates: time 0.04035/0.157, allocations: 24.73 MB / 0.7214 GB, free: 6.711 MB / 0.4981 GB
"
[Timeout remaining time 660]
make -j1 -f OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.makefile [Timeout 660]
(rm -f OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.pipe ; mkfifo OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.pipe >> ../files/OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.sim & ./OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_OpenIPSL.Tests.Machines.PSSE.GENSAL.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 6.168153380043805]
Failed to read output from testmodel.py, exit status != 0:
0.1647234340198338 0.179759031 0.15208585800000002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff529aa2fb0>