Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001573/0.001573, allocations: 113.1 kB / 21.86 MB, free: 80 kB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001753/0.001753, allocations: 210.9 kB / 25.14 MB, free: 3.598 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.441/1.441, allocations: 230.2 MB / 258.5 MB, free: 8.293 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="time|meanCurrent.x|meanVoltage.x|rootMeanSquareVoltage.mean.x|meanCurrent.y|meanVoltage.y|pulse2m.twomPulse.timerNegative.1..entryTime|pulse2m.twomPulse.timerNegative.2..entryTime|pulse2m.twomPulse.timerNegative.3..entryTime|pulse2m.twomPulse.timerPositive.1..entryTime|pulse2m.twomPulse.timerPositive.2..entryTime|pulse2m.twomPulse.timerPositive.3..entryTime|rectifier.pre_n.1..u|rectifier.pre_n.2..u|rectifier.pre_n.3..u|rectifier.pre_p.1..u|rectifier.pre_p.2..u|rectifier.pre_p.3..u|rectifier.thyristor_n.idealThyristor.1..off|rectifier.thyristor_n.idealThyristor.2..off|rectifier.thyristor_n.idealThyristor.3..off|rectifier.thyristor_p.idealThyristor.1..off|rectifier.thyristor_p.idealThyristor.2..off|rectifier.thyristor_p.idealThyristor.3..off|rootMeanSquareVoltage.mean.y",fileNamePrefix="Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R")
translateModel(Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="time|meanCurrent.x|meanVoltage.x|rootMeanSquareVoltage.mean.x|meanCurrent.y|meanVoltage.y|pulse2m.twomPulse.timerNegative.1..entryTime|pulse2m.twomPulse.timerNegative.2..entryTime|pulse2m.twomPulse.timerNegative.3..entryTime|pulse2m.twomPulse.timerPositive.1..entryTime|pulse2m.twomPulse.timerPositive.2..entryTime|pulse2m.twomPulse.timerPositive.3..entryTime|rectifier.pre_n.1..u|rectifier.pre_n.2..u|rectifier.pre_n.3..u|rectifier.pre_p.1..u|rectifier.pre_p.2..u|rectifier.pre_p.3..u|rectifier.thyristor_n.idealThyristor.1..off|rectifier.thyristor_n.idealThyristor.2..off|rectifier.thyristor_n.idealThyristor.3..off|rectifier.thyristor_p.idealThyristor.1..off|rectifier.thyristor_p.idealThyristor.2..off|rectifier.thyristor_p.idealThyristor.3..off|rootMeanSquareVoltage.mean.y",fileNamePrefix="Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.34e-05/2.34e-05, allocations: 2.281 kB / 379.2 MB, free: 2.902 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R): time 0.2177/0.2177, allocations: 6.176 MB / 385.3 MB, free: 11.74 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.004745/0.2225, allocations: 1.943 MB / 387.3 MB, free: 11 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001338/0.2238, allocations: 56.69 kB / 387.3 MB, free: 10.97 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001015/0.2248, allocations: 330.9 kB / 387.7 MB, free: 10.77 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001608/0.2264, allocations: 453.1 kB / 388.1 MB, free: 10.5 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001041/0.2275, allocations: 404.2 kB / 388.5 MB, free: 10.25 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003462/0.2309, allocations: 2.902 MB / 391.4 MB, free: 8.957 MB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001022/0.232, allocations: 0.636 MB / 392 MB, free: 8.559 MB / 302.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001784/0.2337, allocations: 0.9189 MB / 392.9 MB, free: 8.156 MB / 302.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001427/0.2352, allocations: 0.9606 MB / 393.9 MB, free: 7.727 MB / 302.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002548/0.2354, allocations: 165.9 kB / 394.1 MB, free: 7.727 MB / 302.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003786/0.2358, allocations: 175.2 kB / 394.2 MB, free: 7.719 MB / 302.1 MB
Notification: Performance of combineBinaries: time 0.002161/0.238, allocations: 2.743 MB / 397 MB, free: 5.965 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.001305/0.2393, allocations: 1.699 MB / 398.7 MB, free: 4.859 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003968/0.2397, allocations: 209.6 kB / 398.9 MB, free: 4.742 MB / 302.1 MB
Notification: Performance of FrontEnd: time 0.0004579/0.2401, allocations: 53.59 kB / 398.9 MB, free: 4.719 MB / 302.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 452 (248)
 * Number of variables: 452 (207)
Notification: Performance of Bindings: time 0.007683/0.2478, allocations: 7.007 MB / 405.9 MB, free: 252 kB / 302.1 MB
Notification: Performance of FunctionAlias: time 0.0009951/0.2488, allocations: 0.6436 MB / 406.6 MB, free: 15.79 MB / 318.1 MB
Notification: Performance of Early Inline: time 0.004867/0.2537, allocations: 4.093 MB / 410.7 MB, free: 12.59 MB / 318.1 MB
Notification: Performance of Simplify 1: time 0.001196/0.2549, allocations: 0.5616 MB / 411.2 MB, free: 12.15 MB / 318.1 MB
Notification: Performance of Alias: time 0.008073/0.2629, allocations: 5.498 MB / 416.7 MB, free: 7.516 MB / 318.1 MB
Notification: Performance of Simplify 2: time 0.0008054/0.2637, allocations: 452.9 kB / 417.2 MB, free: 7.004 MB / 318.1 MB
Notification: Performance of Remove Stream: time 0.0004195/0.2642, allocations: 344.1 kB / 417.5 MB, free: 6.629 MB / 318.1 MB
Notification: Performance of Detect States: time 0.001095/0.2653, allocations: 0.8599 MB / 418.4 MB, free: 5.707 MB / 318.1 MB
Notification: Performance of Events: time 0.0005748/0.2658, allocations: 375.4 kB / 418.7 MB, free: 5.355 MB / 318.1 MB
Notification: Performance of Partitioning: time 0.001546/0.2674, allocations: 1.185 MB / 419.9 MB, free: 4.074 MB / 318.1 MB
Notification: Performance of Causalize: time 0.009012/0.2764, allocations: 6.303 MB / 426.2 MB, free: 13.66 MB / 334.1 MB
Notification: Performance of After Index Reduction Inline: time 0.003683/0.2801, allocations: 3.203 MB / 429.4 MB, free: 10.46 MB / 334.1 MB
Notification: Performance of Simplify: time 0.004714/0.2848, allocations: 1.76 MB / 431.2 MB, free: 8.543 MB / 334.1 MB
Notification: Performance of Inline: time 0.006804/0.2916, allocations: 5.545 MB / 436.7 MB, free: 2.969 MB / 334.1 MB
Notification: Performance of Partitioning: time 0.0003826/0.292, allocations: 88.08 kB / 436.8 MB, free: 2.859 MB / 334.1 MB
Notification: Performance of Cleanup: time 0.001491/0.2935, allocations: 1.07 MB / 437.9 MB, free: 1.773 MB / 334.1 MB
Notification: Performance of Causalize: time 0.03938/0.3328, allocations: 29.6 MB / 467.5 MB, free: 5.254 MB / 366.1 MB
Notification: Performance of Tearing: time 0.008558/0.3414, allocations: 5.969 MB / 473.5 MB, free: 15.21 MB / 382.1 MB
Notification: Performance of Initialization: time 5.01e-06/0.3414, allocations: 4 kB / 473.5 MB, free: 15.2 MB / 382.1 MB
Notification: Performance of Remove Dummies: time 3.042e-05/0.3414, allocations: 1 kB / 473.5 MB, free: 15.2 MB / 382.1 MB
Notification: Performance of Tearing: time 0.004257/0.3457, allocations: 2.855 MB / 476.3 MB, free: 12.3 MB / 382.1 MB
Notification: Performance of Categorize: time 4.504e-05/0.3457, allocations: 11.98 kB / 476.3 MB, free: 12.29 MB / 382.1 MB
Notification: Performance of Solve: time 0.003054/0.3488, allocations: 1.049 MB / 477.4 MB, free: 11.23 MB / 382.1 MB
Notification: Performance of Jacobian: time 0.00417/0.353, allocations: 2.841 MB / 480.2 MB, free: 8.332 MB / 382.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 9
 * 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: ............................. 3 (3) {meanVoltage.x, rootMeanSquareVoltage.mean.x, meanCurrent.x}
 * Number of discrete states: .................... 9 (5) {pulse2m.twomPulse.timerNegative.entryTime, pulse2m.twomPulse.timerPositive.entryTime, meanCurrent.y, rootMeanSquareVoltage.mean.y_last, meanVoltage.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 84 (36) {rectifier.andCondition_p.u2, rectifier.andCondition_p.y, rectifier.fire_p, rectifier.enableLogic.internalEnable, rectifier.andCondition_n.u2, rectifier.andCondition_n.y, rectifier.fire_n, rectifier.thyristor_p.off, rectifier.thyristor_n.off, rectifier.pre_p.y, rectifier.pre_n.y, pulse2m.twomPulse.positiveThreshold.y, pulse2m.twomPulse.negativeThreshold.y, $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, $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: ........... 78 (scalar:71, array:7, record:0)
 * Number of multi strong components: ............ 3 (algorithm:0, when:3, if:0, tuple:0)
 * Number of for-loop strong components: ......... 39 (resizable: 39, 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: ........... 129 (scalar:118, array:11, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 69 (resizable: 69, 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: ........... 129 (scalar:118, array:11, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 69 (resizable: 69, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0002155/0.3532, allocations: 124.6 kB / 480.4 MB, free: 8.223 MB / 382.1 MB
Notification: Performance of SimCode: time 0.02031/0.3735, allocations: 14.28 MB / 494.6 MB, free: 9.766 MB / 398.1 MB
Notification: Performance of Templates: time 0.04988/0.4234, allocations: 30.08 MB / 0.5124 GB, free: 11.74 MB / 430.1 MB
"
[Timeout remaining time 660]
make -j1 -f Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.makefile [Timeout 660]
(rm -f Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.pipe ; mkfifo Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.pipe >> ../files/Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.sim & ./Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_trunk_Modelica.Electrical.PowerConverters.Examples.ACDC.RectifierBridge2mPulse.ThyristorBridge2mPulse_R.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 12.100475343875587]
Failed to read output from testmodel.py, exit status != 0:
['time', 'meanCurrent.x', 'meanVoltage.x', 'rootMeanSquareVoltage.mean.x', 'meanCurrent.y', 'meanVoltage.y', 'pulse2m.twomPulse.timerNegative[1].entryTime', 'pulse2m.twomPulse.timerNegative[2].entryTime', 'pulse2m.twomPulse.timerNegative[3].entryTime', 'pulse2m.twomPulse.timerPositive[1].entryTime', 'pulse2m.twomPulse.timerPositive[2].entryTime', 'pulse2m.twomPulse.timerPositive[3].entryTime', 'rectifier.pre_n[1].u', 'rectifier.pre_n[2].u', 'rectifier.pre_n[3].u', 'rectifier.pre_p[1].u', 'rectifier.pre_p[2].u', 'rectifier.pre_p[3].u', 'rectifier.thyristor_n.idealThyristor[1].off', 'rectifier.thyristor_n.idealThyristor[2].off', 'rectifier.thyristor_n.idealThyristor[3].off', 'rectifier.thyristor_p.idealThyristor[1].off', 'rectifier.thyristor_p.idealThyristor[2].off', 'rectifier.thyristor_p.idealThyristor[3].off', 'rootMeanSquareVoltage.mean.y']
0.4328105514869094 0.447025429 0.203656956
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe21c35d780>