Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0_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.00169/0.00169, allocations: 103.6 kB / 21.25 MB, free: 0.5664 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.002087/0.002087, allocations: 212.5 kB / 24.55 MB, free: 3.828 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.482/1.482, allocations: 230.6 MB / 258.3 MB, free: 7.738 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo): time 0.2677/0.2677, allocations: 46.98 MB / 361.7 MB, free: 3.988 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 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 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_4.1.0_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_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.184e-05/2.184e-05, allocations: 6.219 kB / 0.4974 GB, free: 7.215 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal): time 0.009083/0.009105, allocations: 6.809 MB / 0.5041 GB, free: 380 kB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.005018/0.01412, allocations: 2.303 MB / 0.5063 GB, free: 14.06 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005444/0.01467, allocations: 27.94 kB / 0.5063 GB, free: 14.04 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004257/0.01892, allocations: 1.687 MB / 0.508 GB, free: 12.34 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001966/0.02089, allocations: 0.7046 MB / 0.5087 GB, free: 11.64 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002454/0.02334, allocations: 1.038 MB / 0.5097 GB, free: 10.61 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002083/0.02543, allocations: 1.713 MB / 0.5114 GB, free: 8.891 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001438/0.02687, allocations: 0.8447 MB / 0.5122 GB, free: 8.02 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009492/0.02781, allocations: 0.7005 MB / 0.5129 GB, free: 7.316 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008066/0.02862, allocations: 0.6995 MB / 0.5135 GB, free: 6.613 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001721/0.02879, allocations: 112 kB / 0.5137 GB, free: 6.504 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007819/0.02958, allocations: 319.8 kB / 0.514 GB, free: 6.191 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.002695/0.03227, allocations: 3.039 MB / 0.5169 GB, free: 3.121 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.001974/0.03424, allocations: 1.978 MB / 0.5189 GB, free: 1.117 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0002493/0.03449, allocations: 104 kB / 0.519 GB, free: 1.016 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0002131/0.03471, allocations: 39.91 kB / 0.519 GB, free: 0.9766 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: 339 (280)
 * Number of variables: 339 (339)
Notification: Performance of [SIM] Bindings: time 0.2321/0.2668, allocations: 8.385 MB / 0.5272 GB, free: 19.24 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001338/0.2681, allocations: 1.325 MB / 0.5285 GB, free: 19.08 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.009833/0.2779, allocations: 8.918 MB / 0.5372 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.00155/0.2795, allocations: 0.7819 MB / 0.5379 GB, free: 14.58 MB / 382.1 MB
Notification: Performance of [SIM] Alias: time 0.004568/0.284, allocations: 4.171 MB / 0.542 GB, free: 11.87 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001134/0.2852, allocations: 0.7655 MB / 0.5428 GB, free: 11.54 MB / 382.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0006025/0.2858, allocations: 0.5194 MB / 0.5433 GB, free: 11.17 MB / 382.1 MB
Notification: Performance of [SIM] Detect States: time 0.00112/0.2869, allocations: 1.325 MB / 0.5446 GB, free: 10.25 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 0.0005839/0.2875, allocations: 395.1 kB / 0.5449 GB, free: 10.05 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.002401/0.2899, allocations: 2.339 MB / 0.5472 GB, free: 8.715 MB / 382.1 MB
Notification: Performance of [SIM] Causalize: time 0.009978/0.2999, allocations: 7.901 MB / 0.5549 GB, free: 5.797 MB / 382.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002883/0.3028, allocations: 4.593 MB / 0.5594 GB, free: 1.668 MB / 382.1 MB
Notification: Performance of [INI] Simplify: time 0.00256/0.3053, allocations: 1.735 MB / 0.5611 GB, free: 15.76 MB / 398.1 MB
Notification: Performance of [INI] Inline: time 0.007902/0.3132, allocations: 7.994 MB / 0.5689 GB, free: 7.828 MB / 398.1 MB
Notification: Performance of [INI] Partitioning: time 0.0002972/0.3135, allocations: 119.4 kB / 0.569 GB, free: 7.688 MB / 398.1 MB
Notification: Performance of [INI] Cleanup: time 0.001282/0.3148, allocations: 1.176 MB / 0.5702 GB, free: 6.535 MB / 398.1 MB
Notification: Performance of [INI] Causalize: time 0.01185/0.3266, allocations: 7.233 MB / 0.5773 GB, free: 15.22 MB / 414.1 MB
Notification: Performance of [INI] Tearing: time 0.0009262/0.3276, allocations: 0.7076 MB / 0.5779 GB, free: 14.54 MB / 414.1 MB
Notification: Performance of [SIM] Initialization: time 1.293e-06/0.3276, allocations: 3.938 kB / 0.578 GB, free: 14.54 MB / 414.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.003293/0.3309, allocations: 1.995 MB / 0.5799 GB, free: 12.59 MB / 414.1 MB
Notification: Performance of [SIM] Remove Dummies: time 2e-05/0.3309, allocations: 2.656 kB / 0.5799 GB, free: 12.58 MB / 414.1 MB
Notification: Performance of [SIM] Tearing: time 0.001015/0.3319, allocations: 0.8799 MB / 0.5808 GB, free: 11.73 MB / 414.1 MB
Notification: Performance of [SIM] Categorize: time 5.249e-05/0.3319, allocations: 12 kB / 0.5808 GB, free: 11.72 MB / 414.1 MB
Notification: Performance of [SIM] Solve: time 0.01079/0.3427, allocations: 7.49 MB / 0.5881 GB, free: 4.305 MB / 414.1 MB
Notification: Performance of [SIM] Jacobian: time 0.01409/0.3568, allocations: 9.073 MB / 0.5969 GB, free: 11.36 MB / 430.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: ........... 235 (scalar:235, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:7)
 * 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: ........... 247 (scalar:247, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:7)
 * 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.0001797/0.357, allocations: 90.06 kB / 0.597 GB, free: 11.28 MB / 430.1 MB
Notification: Performance of SimCode: time 0.01285/0.3699, allocations: 8.888 MB / 0.6057 GB, free: 2.219 MB / 430.1 MB
Notification: Performance of Templates: time 0.05523/0.4251, allocations: 30.08 MB / 0.6351 GB, free: 4.281 MB / 462.1 MB
"
[Timeout remaining time 660]
make -j1 -f ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe ; mkfifo ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe ; head -c 1048576 < ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe >> ../files/ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.sim & ./ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0_ModelicaTest.Electrical.QuasiStatic.SinglePhase.Ideal.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 6.328460064949468]
Failed to read output from testmodel.py, exit status != 0:
['time', 'I.re', 'I.im']
0.433913376997225 0.448670104 0.41082978400000003
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbc6bf3afb0>