Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.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.002242/0.002242, allocations: 109.3 kB / 21.99 MB, free: 4.551 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.002299/0.002299, allocations: 213.5 kB / 25.3 MB, free: 2.902 MB / 14.72 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.752/1.752, allocations: 207.7 MB / 236.2 MB, free: 9.766 MB / 190.1 MB
"
[Timeout remaining time 178]
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 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(Modelica.Electrical.Spice3.Examples.CoupledInductors,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|L1.iinternal|L2.iinternal|L3.iinternal",fileNamePrefix="Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors")
translateModel(Modelica.Electrical.Spice3.Examples.CoupledInductors,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|L1.iinternal|L2.iinternal|L3.iinternal",fileNamePrefix="Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.288e-05/2.288e-05, allocations: 2.281 kB / 348.5 MB, free: 9.379 MB / 286.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Spice3.Examples.CoupledInductors): time 0.004599/0.004622, allocations: 2.52 MB / 351 MB, free: 6.84 MB / 286.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001402/0.006024, allocations: 0.7137 MB / 351.8 MB, free: 6.117 MB / 286.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001145/0.006138, allocations: 4 kB / 351.8 MB, free: 6.113 MB / 286.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001454/0.006284, allocations: 75.34 kB / 351.8 MB, free: 6.039 MB / 286.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002019/0.006486, allocations: 87.12 kB / 351.9 MB, free: 5.953 MB / 286.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0003959/0.006881, allocations: 123.8 kB / 352 MB, free: 5.832 MB / 286.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0006604/0.007542, allocations: 0.4989 MB / 352.5 MB, free: 5.332 MB / 286.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003308/0.007873, allocations: 137.8 kB / 352.7 MB, free: 5.195 MB / 286.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002708/0.008143, allocations: 195.3 kB / 352.9 MB, free: 5.004 MB / 286.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002697/0.008413, allocations: 167.1 kB / 353 MB, free: 4.84 MB / 286.1 MB
Notification: Performance of NFPackage.collectConstants: time 7.569e-05/0.008489, allocations: 48 kB / 353.1 MB, free: 4.793 MB / 286.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 7.812e-05/0.008567, allocations: 44 kB / 353.1 MB, free: 4.75 MB / 286.1 MB
Notification: Performance of combineBinaries: time 0.0007194/0.009286, allocations: 0.7621 MB / 353.9 MB, free: 3.98 MB / 286.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0003467/0.009633, allocations: 477.6 kB / 354.3 MB, free: 3.508 MB / 286.1 MB
Notification: Performance of NFVerifyModel.verify: time 6.548e-05/0.009698, allocations: 40 kB / 354.4 MB, free: 3.469 MB / 286.1 MB
Notification: Performance of FrontEnd: time 3.735e-05/0.009736, allocations: 12 kB / 354.4 MB, free: 3.457 MB / 286.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 103 (103)
 * Number of variables: 103 (103)
Notification: Performance of [SIM] Bindings: time 0.002089/0.01183, allocations: 1.925 MB / 356.3 MB, free: 1.395 MB / 286.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0003943/0.01222, allocations: 275.6 kB / 356.6 MB, free: 1.113 MB / 286.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001162/0.01338, allocations: 1.109 MB / 357.7 MB, free: 15.97 MB / 302.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0003712/0.01375, allocations: 240.1 kB / 357.9 MB, free: 15.7 MB / 302.1 MB
Notification: Performance of [SIM] Alias: time 0.00314/0.01689, allocations: 2.049 MB / 360 MB, free: 13.44 MB / 302.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0002417/0.01713, allocations: 161.8 kB / 360.1 MB, free: 13.24 MB / 302.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001317/0.01727, allocations: 101.1 kB / 360.2 MB, free: 13.11 MB / 302.1 MB
Notification: Performance of [SIM] Detect States: time 0.0003522/0.01762, allocations: 261.6 kB / 360.5 MB, free: 12.8 MB / 302.1 MB
Notification: Performance of [SIM] Events: time 0.0001602/0.01778, allocations: 82.31 kB / 360.6 MB, free: 12.72 MB / 302.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0005132/0.01829, allocations: 410.4 kB / 361 MB, free: 12.25 MB / 302.1 MB
Notification: Performance of [SIM] Causalize: time 0.001086/0.01938, allocations: 0.7918 MB / 361.8 MB, free: 11.41 MB / 302.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.000573/0.01995, allocations: 0.575 MB / 362.3 MB, free: 10.84 MB / 302.1 MB
Notification: Performance of [INI] Simplify: time 0.0007286/0.02068, allocations: 416.2 kB / 362.7 MB, free: 10.36 MB / 302.1 MB
Notification: Performance of [INI] Inline: time 0.0008912/0.02157, allocations: 0.8741 MB / 363.6 MB, free: 9.48 MB / 302.1 MB
Notification: Performance of [INI] Partitioning: time 5.48e-05/0.02162, allocations: 35.94 kB / 363.7 MB, free: 9.438 MB / 302.1 MB
Notification: Performance of [INI] Cleanup: time 0.0001426/0.02177, allocations: 151.9 kB / 363.8 MB, free: 9.289 MB / 302.1 MB
Notification: Performance of [INI] Causalize: time 0.002341/0.02411, allocations: 1.622 MB / 365.4 MB, free: 7.645 MB / 302.1 MB
Notification: Performance of [INI] Tearing: time 3.31e-05/0.02414, allocations: 36 kB / 365.5 MB, free: 7.609 MB / 302.1 MB
Notification: Performance of [SIM] Initialization: time 7.22e-07/0.02414, allocations: 0 / 365.5 MB, free: 7.609 MB / 302.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0004613/0.0246, allocations: 297.3 kB / 365.7 MB, free: 7.258 MB / 302.1 MB
Notification: Performance of [SIM] Remove Dummies: time 7.844e-06/0.02461, allocations: 4.281 kB / 365.8 MB, free: 7.254 MB / 302.1 MB
Notification: Performance of [SIM] Tearing: time 0.0001164/0.02473, allocations: 99.83 kB / 365.8 MB, free: 7.156 MB / 302.1 MB
Notification: Performance of [SIM] Categorize: time 1.977e-05/0.02475, allocations: 7.984 kB / 365.9 MB, free: 7.148 MB / 302.1 MB
Notification: Performance of [SIM] Solve: time 0.001301/0.02605, allocations: 0.9632 MB / 366.8 MB, free: 6.18 MB / 302.1 MB
Notification: Performance of [SIM] Jacobian: time 0.001576/0.02762, allocations: 1.323 MB / 368.1 MB, free: 4.746 MB / 302.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 7
 * 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: ............................. 5 (5) {C1.vinternal, C2.vinternal, L1.i, R2.i, R4.i}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 8 (8) {$SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 40 (scalar:40, 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: ........... 69 (scalar:69, 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: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 6.689e-05/0.02769, allocations: 42.7 kB / 368.2 MB, free: 4.707 MB / 302.1 MB
Notification: Performance of SimCode: time 0.001993/0.02968, allocations: 1.515 MB / 369.7 MB, free: 3.16 MB / 302.1 MB
Notification: Performance of Templates: time 0.008774/0.03846, allocations: 3.979 MB / 373.7 MB, free: 15.18 MB / 318.1 MB
"
[Timeout remaining time 660]
make -j1 -f Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.makefile [Timeout 660]
(rm -f Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.pipe ; mkfifo Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.pipe ; head -c 1048576 < Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.pipe >> ../files/Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.sim & ./Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_3.2.3_Modelica.Electrical.Spice3.Examples.CoupledInductors.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.043212685035542]
Failed to read output from testmodel.py, exit status != 0:
['time', 'L1.iinternal', 'L2.iinternal', 'L3.iinternal']
0.04664615000365302 0.06168499400000001 0.048904949
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc3f2c9efb0>