Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.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.001444/0.001444, allocations: 100.4 kB / 20.52 MB, free: 1.148 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.001546/0.001546, allocations: 215.3 kB / 23.82 MB, free: 4.344 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.571/1.571, allocations: 207.7 MB / 234.7 MB, free: 9.77 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.2249/0.2249, allocations: 44.26 MB / 331.2 MB, free: 9.371 MB / 270.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo)
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(ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5006,variableFilter="time|I.re|I.im",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal")
translateModel(ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5006,variableFilter="time|I.re|I.im",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.214e-05/2.214e-05, allocations: 3.828 kB / 468.8 MB, free: 3.867 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal): time 0.009528/0.00955, allocations: 6.797 MB / 475.6 MB, free: 13.04 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.005729/0.01528, allocations: 2.248 MB / 477.9 MB, free: 10.78 MB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008663/0.01615, allocations: 35.88 kB / 477.9 MB, free: 10.74 MB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00433/0.02048, allocations: 1.69 MB / 479.6 MB, free: 9.047 MB / 350.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002531/0.02301, allocations: 0.718 MB / 480.3 MB, free: 8.328 MB / 350.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002599/0.02561, allocations: 1.032 MB / 481.3 MB, free: 7.305 MB / 350.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002674/0.02828, allocations: 1.748 MB / 483.1 MB, free: 5.555 MB / 350.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001549/0.02983, allocations: 0.8564 MB / 483.9 MB, free: 4.672 MB / 350.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001098/0.03093, allocations: 0.7121 MB / 484.7 MB, free: 3.957 MB / 350.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008939/0.03182, allocations: 0.7034 MB / 485.4 MB, free: 3.25 MB / 350.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001845/0.032, allocations: 116 kB / 485.5 MB, free: 3.137 MB / 350.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009386/0.03294, allocations: 323.8 kB / 485.8 MB, free: 2.82 MB / 350.1 MB
Notification: Performance of combineBinaries: time 0.002945/0.03589, allocations: 3.117 MB / 488.9 MB, free: 15.67 MB / 366.1 MB
Notification: Performance of replaceArrayConstructors: time 0.00194/0.03783, allocations: 2.02 MB / 490.9 MB, free: 13.62 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003559/0.03818, allocations: 112 kB / 491 MB, free: 13.51 MB / 366.1 MB
Notification: Performance of FrontEnd: time 0.0002664/0.03845, allocations: 43.84 kB / 491.1 MB, free: 13.47 MB / 366.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 349 (289)
 * Number of variables: 349 (349)
Notification: Performance of [SIM] Bindings: time 0.009577/0.04803, allocations: 8.584 MB / 499.7 MB, free: 4.559 MB / 366.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001719/0.04975, allocations: 1.337 MB / 0.4893 GB, free: 3.203 MB / 366.1 MB
Notification: Performance of [SIM] Early Inline: time 0.01138/0.06113, allocations: 9.151 MB / 0.4982 GB, free: 9.984 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001895/0.06302, allocations: 0.8035 MB / 0.499 GB, free: 9.07 MB / 382.1 MB
Notification: Performance of [SIM] Alias: time 0.006362/0.06938, allocations: 4.284 MB / 0.5032 GB, free: 4.434 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001331/0.07071, allocations: 0.7542 MB / 0.5039 GB, free: 3.566 MB / 382.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0006691/0.07138, allocations: 0.5414 MB / 0.5044 GB, free: 2.965 MB / 382.1 MB
Notification: Performance of [SIM] Detect States: time 0.001609/0.07299, allocations: 1.365 MB / 0.5058 GB, free: 1.504 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 0.0006429/0.07364, allocations: 372.1 kB / 0.5061 GB, free: 1.125 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.003037/0.07667, allocations: 2.396 MB / 0.5085 GB, free: 14.67 MB / 398.1 MB
Notification: Performance of [SIM] Causalize: time 0.01284/0.08951, allocations: 7.813 MB / 0.5161 GB, free: 6.664 MB / 398.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.005129/0.09464, allocations: 4.723 MB / 0.5207 GB, free: 1.938 MB / 398.1 MB
Notification: Performance of [INI] Simplify: time 0.003451/0.09809, allocations: 1.763 MB / 0.5224 GB, free: 15.97 MB / 414.1 MB
Notification: Performance of [INI] Inline: time 0.008635/0.1067, allocations: 8.21 MB / 0.5304 GB, free: 7.742 MB / 414.1 MB
Notification: Performance of [INI] Partitioning: time 0.0004653/0.1072, allocations: 115.7 kB / 0.5305 GB, free: 7.602 MB / 414.1 MB
Notification: Performance of [INI] Cleanup: time 0.001868/0.1091, allocations: 1.194 MB / 0.5317 GB, free: 6.406 MB / 414.1 MB
Notification: Performance of [INI] Causalize: time 0.2806/0.3896, allocations: 7.163 MB / 0.5387 GB, free: 60.76 MB / 414.1 MB
Notification: Performance of [INI] Tearing: time 0.001093/0.3907, allocations: 0.7127 MB / 0.5394 GB, free: 60.74 MB / 414.1 MB
Notification: Performance of [SIM] Initialization: time 2.364e-06/0.3907, allocations: 0 / 0.5394 GB, free: 60.74 MB / 414.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.003489/0.3942, allocations: 2.077 MB / 0.5414 GB, free: 60.4 MB / 414.1 MB
Notification: Performance of [SIM] Remove Dummies: time 2.246e-05/0.3942, allocations: 4.656 kB / 0.5414 GB, free: 60.4 MB / 414.1 MB
Notification: Performance of [SIM] Tearing: time 0.0009591/0.3952, allocations: 0.8789 MB / 0.5423 GB, free: 60.18 MB / 414.1 MB
Notification: Performance of [SIM] Categorize: time 7.251e-05/0.3953, allocations: 19.33 kB / 0.5423 GB, free: 60.18 MB / 414.1 MB
Notification: Performance of [SIM] Solve: time 0.01231/0.4076, allocations: 7.723 MB / 0.5499 GB, free: 59.39 MB / 414.1 MB
Notification: Performance of [SIM] Jacobian: time 0.01402/0.4216, allocations: 9.106 MB / 0.5587 GB, free: 56.32 MB / 414.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: ............... 0
 * Number of algebraic event partitions: ......... 1
 * 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: ............................. 1 (1) {idealOpeningSwitch.pin_p.reference.gamma}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 18 (18) {booleanStep1.y, booleanStep2.y, booleanStep3.y, booleanStep4.y, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 243 (scalar:243, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:8)
 * 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: ........... 255 (scalar:255, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:8)
 * 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.0002495/0.4218, allocations: 92.48 kB / 0.5588 GB, free: 56.24 MB / 414.1 MB
Notification: Performance of SimCode: time 0.01195/0.4338, allocations: 8.973 MB / 0.5676 GB, free: 52.09 MB / 414.1 MB
Notification: Performance of Templates: time 0.04181/0.4756, allocations: 30.3 MB / 0.5972 GB, free: 28.05 MB / 414.1 MB
"
[Timeout remaining time 660]
make -j1 -f ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.makefile [Timeout 660]
(rm -f ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe >> ../files/ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.sim & ./ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_3.2.3_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 6.473796769976616]
Failed to read output from testmodel.py, exit status != 0:
['time', 'I.re', 'I.im']
0.48414919897913933 0.493988637 0.45322282100000005
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcfb63aafb0>