Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.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.001429/0.001429, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.001482/0.001482, allocations: 215.5 kB / 23.07 MB, free: 4.844 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.464/1.464, allocations: 230.7 MB / 256.9 MB, free: 7.77 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.07841/0.07841, allocations: 16.93 MB / 330.2 MB, free: 2.359 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package PowerGrids with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/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(PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine")
translateModel(PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.14e-05/2.14e-05, allocations: 6.219 kB / 461.2 MB, free: 1.82 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine): time 0.0372/0.03722, allocations: 35.76 MB / 497 MB, free: 13.92 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01855/0.05577, allocations: 9.819 MB / 0.4949 GB, free: 4.062 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004891/0.06066, allocations: 103.2 kB / 0.495 GB, free: 3.961 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004875/0.06553, allocations: 1.386 MB / 0.4964 GB, free: 2.566 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01382/0.07935, allocations: 4.539 MB / 0.5008 GB, free: 14.05 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005492/0.08484, allocations: 1.903 MB / 0.5027 GB, free: 12.19 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01483/0.09968, allocations: 10.24 MB / 0.5127 GB, free: 1.93 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004203/0.1039, allocations: 1.573 MB / 0.5142 GB, free: 320 kB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.2273/0.3312, allocations: 3.217 MB / 0.5173 GB, free: 22.07 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.007166/0.3383, allocations: 3.249 MB / 0.5205 GB, free: 21.62 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001376/0.3397, allocations: 292.1 kB / 0.5208 GB, free: 21.62 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004802/0.3445, allocations: 1.014 MB / 0.5218 GB, free: 21.62 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.01345/0.358, allocations: 12.68 MB / 0.5342 GB, free: 16.85 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.008893/0.3669, allocations: 7.194 MB / 0.5412 GB, free: 12.93 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004398/0.3713, allocations: 420.2 kB / 0.5416 GB, free: 12.93 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.001279/0.3725, allocations: 134.4 kB / 0.5417 GB, free: 12.92 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 804 (602)
 * Number of variables: 804 (804)
Notification: Performance of [SIM] Bindings: time 0.03304/0.4056, allocations: 30.27 MB / 0.5713 GB, free: 13.92 MB / 398.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.003709/0.4093, allocations: 2.654 MB / 0.5739 GB, free: 12.53 MB / 398.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0194/0.4287, allocations: 16.82 MB / 0.5903 GB, free: 14.59 MB / 414.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.004344/0.433, allocations: 1.475 MB / 0.5917 GB, free: 13 MB / 414.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.02252/0.4556, allocations: 13.22 MB / 0.6046 GB, free: 14.73 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.002628/0.4582, allocations: 1.323 MB / 0.6059 GB, free: 13.27 MB / 430.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.001366/0.4595, allocations: 1.049 MB / 0.607 GB, free: 12.15 MB / 430.1 MB
Notification: Performance of [SIM] Detect States: time 0.002337/0.4619, allocations: 2.342 MB / 0.6093 GB, free: 9.754 MB / 430.1 MB
Notification: Performance of [SIM] Events: time 0.001154/0.463, allocations: 0.7433 MB / 0.61 GB, free: 9.016 MB / 430.1 MB
Notification: Performance of [SIM] Partitioning: time 0.005504/0.4685, allocations: 4.62 MB / 0.6145 GB, free: 4.016 MB / 430.1 MB
Notification: Performance of [SIM] Causalize: time 0.01703/0.4856, allocations: 11.69 MB / 0.6259 GB, free: 7.977 MB / 446.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.009469/0.495, allocations: 8.24 MB / 0.634 GB, free: 15.81 MB / 462.1 MB
Notification: Performance of [INI] Simplify: time 0.01562/0.5107, allocations: 6.703 MB / 0.6405 GB, free: 9.008 MB / 462.1 MB
Notification: Performance of [INI] Inline: time 0.02935/0.54, allocations: 19.88 MB / 0.6599 GB, free: 5.395 MB / 478.1 MB
Notification: Performance of [INI] Partitioning: time 0.001844/0.5419, allocations: 333 kB / 0.6602 GB, free: 5.012 MB / 478.1 MB
Notification: Performance of [INI] Cleanup: time 0.005579/0.5474, allocations: 2.441 MB / 0.6626 GB, free: 2.625 MB / 478.1 MB
Notification: Performance of [INI] Causalize: time 0.03552/0.583, allocations: 20.04 MB / 0.6822 GB, free: 14.5 MB / 0.4981 GB
Notification: Performance of [INI] Tearing: time 0.0005224/0.5835, allocations: 0.5273 MB / 0.6827 GB, free: 13.98 MB / 0.4981 GB
Notification: Performance of [SIM] Initialization: time 1.963e-06/0.5835, allocations: 0 / 0.6827 GB, free: 13.98 MB / 0.4981 GB
Notification: Performance of [SIM] DAE-Mode: time 0.00665/0.5901, allocations: 3.921 MB / 0.6865 GB, free: 9.816 MB / 0.4981 GB
Notification: Performance of [SIM] Remove Dummies: time 5.723e-05/0.5902, allocations: 16.28 kB / 0.6865 GB, free: 9.805 MB / 0.4981 GB
Notification: Performance of [SIM] Tearing: time 0.000493/0.5907, allocations: 0.6613 MB / 0.6872 GB, free: 9.164 MB / 0.4981 GB
Notification: Performance of [SIM] Categorize: time 0.0001467/0.5908, allocations: 41.36 kB / 0.6872 GB, free: 9.141 MB / 0.4981 GB
Notification: Performance of [SIM] Solve: time 0.2583/0.8491, allocations: 16.19 MB / 0.703 GB, free: 111.1 MB / 0.4981 GB
Notification: Performance of [SIM] Jacobian: time 0.00674/0.8559, allocations: 11.79 MB / 0.7145 GB, free: 100.4 MB / 0.4981 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 48
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 4
 * 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: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 24 (24) {$SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_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: ........... 548 (scalar:548, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:48)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 2 (linear: 2, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 970 (scalar:970, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:48)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 2 (linear: 2, nonlinear:0)
Notification: Performance of backend: time 0.0004118/0.8563, allocations: 234.6 kB / 0.7148 GB, free: 100.3 MB / 0.4981 GB
Notification: Performance of SimCode: time 0.0285/0.8848, allocations: 22.2 MB / 0.7364 GB, free: 94.29 MB / 0.4981 GB
Notification: Performance of Templates: time 0.08265/0.9674, allocations: 59.94 MB / 0.795 GB, free: 51.45 MB / 0.4981 GB
"
[Timeout remaining time 659]
make -j1 -f PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.makefile [Timeout 660]
(rm -f PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe ; mkfifo PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe >> ../files/PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.sim & ./PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine  -abortSlowSimulation -alarm=480 -lv LOG_STATS > PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 8.051049941976089]
Failed to read output from testmodel.py, exit status != 0:
0.976040331996046 0.984955186 0.609951174
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f46aa972dd0>