Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.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.001399/0.001399, allocations: 107.6 kB / 21.25 MB, free: 0.5625 MB / 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.001529/0.001529, allocations: 222.3 kB / 24.56 MB, free: 3.816 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.588/1.588, allocations: 230.5 MB / 258.2 MB, free: 7.707 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2442/0.2442, allocations: 46.95 MB / 361.7 MB, free: 3.879 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
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(ModelicaTest.Blocks.LimitersHomotopy,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|controllerFeedbackPart1.y|controllerFeedbackPart2.y|controllerFeedbackPart3.y|controllerFeedbackPart4.y|controllerFeedbackPart5.y|controllerFeedbackPart6.y|firstOrder1.y|firstOrder2.y|firstOrder3.y|firstOrder4.y|firstOrder5.y|firstOrder6.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy")
translateModel(ModelicaTest.Blocks.LimitersHomotopy,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|controllerFeedbackPart1.y|controllerFeedbackPart2.y|controllerFeedbackPart3.y|controllerFeedbackPart4.y|controllerFeedbackPart5.y|controllerFeedbackPart6.y|firstOrder1.y|firstOrder2.y|firstOrder3.y|firstOrder4.y|firstOrder5.y|firstOrder6.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.532e-05/3.532e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.035 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Blocks.LimitersHomotopy): time 0.004421/0.004456, allocations: 2.753 MB / 0.5001 GB, free: 4.266 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002204/0.00666, allocations: 0.9901 MB / 0.5011 GB, free: 3.27 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002165/0.006877, allocations: 19.88 kB / 0.5011 GB, free: 3.25 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001408/0.007018, allocations: 63.2 kB / 0.5012 GB, free: 3.188 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002482/0.007266, allocations: 87 kB / 0.5013 GB, free: 3.102 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0008568/0.008123, allocations: 379.3 kB / 0.5016 GB, free: 2.734 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0008178/0.008941, allocations: 0.8432 MB / 0.5024 GB, free: 1.887 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003492/0.00929, allocations: 156.9 kB / 0.5026 GB, free: 1.73 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004972/0.009787, allocations: 362.9 kB / 0.5029 GB, free: 1.375 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002643/0.01005, allocations: 238.6 kB / 0.5032 GB, free: 1.141 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 8.372e-05/0.01013, allocations: 48 kB / 0.5032 GB, free: 1.094 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001085/0.01024, allocations: 52 kB / 0.5033 GB, free: 1.043 MB / 366.1 MB
Notification: Performance of combineBinaries: time 0.000848/0.01109, allocations: 1.082 MB / 0.5043 GB, free: 15.95 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0004595/0.01155, allocations: 0.682 MB / 0.505 GB, free: 15.26 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 6.548e-05/0.01162, allocations: 47.94 kB / 0.505 GB, free: 15.21 MB / 382.1 MB
Notification: Performance of FrontEnd: time 8.312e-05/0.0117, allocations: 31.69 kB / 0.5051 GB, free: 15.18 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: 109 (109)
 * Number of variables: 109 (109)
Notification: Performance of [SIM] Bindings: time 0.002605/0.0143, allocations: 2.567 MB / 0.5076 GB, free: 12.47 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0003948/0.0147, allocations: 327.6 kB / 0.5079 GB, free: 12.13 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001601/0.0163, allocations: 1.53 MB / 0.5094 GB, free: 10.57 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0005551/0.01686, allocations: 356.2 kB / 0.5097 GB, free: 10.17 MB / 382.1 MB
Notification: Performance of [SIM] Alias: time 0.003549/0.02041, allocations: 2.621 MB / 0.5123 GB, free: 7.086 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0003902/0.0208, allocations: 289.8 kB / 0.5126 GB, free: 6.754 MB / 382.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001514/0.02095, allocations: 132.2 kB / 0.5127 GB, free: 6.598 MB / 382.1 MB
Notification: Performance of [SIM] Detect States: time 0.0004267/0.02137, allocations: 359 kB / 0.513 GB, free: 6.195 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 0.0004083/0.02178, allocations: 262.9 kB / 0.5133 GB, free: 5.938 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0006879/0.02247, allocations: 0.5892 MB / 0.5138 GB, free: 5.273 MB / 382.1 MB
Notification: Performance of [SIM] Causalize: time 0.001531/0.024, allocations: 1.074 MB / 0.5149 GB, free: 4.125 MB / 382.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001063/0.02506, allocations: 1.062 MB / 0.5159 GB, free: 3.062 MB / 382.1 MB
Notification: Performance of [INI] Simplify: time 0.0009383/0.026, allocations: 0.5952 MB / 0.5165 GB, free: 2.395 MB / 382.1 MB
Notification: Performance of [INI] Inline: time 0.001718/0.02772, allocations: 1.647 MB / 0.5181 GB, free: 0.7383 MB / 382.1 MB
Notification: Performance of [INI] Partitioning: time 6.55e-05/0.02778, allocations: 40 kB / 0.5182 GB, free: 0.6953 MB / 382.1 MB
Notification: Performance of [INI] Cleanup: time 0.0003582/0.02814, allocations: 343.6 kB / 0.5185 GB, free: 360 kB / 382.1 MB
Notification: Performance of [INI] Causalize: time 0.2599/0.2881, allocations: 2.589 MB / 0.521 GB, free: 27.88 MB / 382.1 MB
Notification: Performance of [INI] Tearing: time 0.00196/0.29, allocations: 1.505 MB / 0.5225 GB, free: 27.7 MB / 382.1 MB
Notification: Performance of [SIM] Initialization: time 2.304e-06/0.29, allocations: 0 / 0.5225 GB, free: 27.7 MB / 382.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0006747/0.2907, allocations: 0.5003 MB / 0.523 GB, free: 27.49 MB / 382.1 MB
Notification: Performance of [SIM] Remove Dummies: time 9.257e-06/0.2907, allocations: 2.75 kB / 0.523 GB, free: 27.49 MB / 382.1 MB
Notification: Performance of [SIM] Tearing: time 4.501e-05/0.2907, allocations: 73.38 kB / 0.523 GB, free: 27.46 MB / 382.1 MB
Notification: Performance of [SIM] Categorize: time 2.549e-05/0.2908, allocations: 4.828 kB / 0.5231 GB, free: 27.46 MB / 382.1 MB
Notification: Performance of [SIM] Solve: time 0.002761/0.2935, allocations: 2.017 MB / 0.525 GB, free: 27.13 MB / 382.1 MB
Notification: Performance of [SIM] Jacobian: time 0.003463/0.297, allocations: 5.353 MB / 0.5303 GB, free: 22.62 MB / 382.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: ............... 6
 * Number of algebraic event partitions: ......... 4
 * 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: ............................. 12 (12) {controllerFeedbackPart1.y, firstOrder1.y, controllerFeedbackPart2.y, firstOrder2.y, controllerFeedbackPart3.y, firstOrder3.y, controllerFeedbackPart4.y, firstOrder4.y, controllerFeedbackPart5.y, firstOrder5.y, controllerFeedbackPart6.y, firstOrder6.y}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 28 (28) {$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, $TEV_11, $TEV_10, $TEV_9, $TEV_8, $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: ........... 70 (scalar:70, 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: ........... 38 (scalar:38, 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: ... 7 (linear: 7, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 72 (scalar:72, 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: ... 2 (linear: 2, nonlinear:0)
Notification: Performance of backend: time 0.0001619/0.2972, allocations: 73.25 kB / 0.5303 GB, free: 22.57 MB / 382.1 MB
Notification: Performance of SimCode: time 0.003159/0.3003, allocations: 2.304 MB / 0.5326 GB, free: 21.68 MB / 382.1 MB
Notification: Performance of Templates: time 0.01512/0.3154, allocations: 8.156 MB / 0.5405 GB, free: 19.73 MB / 382.1 MB
"
[Timeout remaining time 660]
make -j1 -f ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.makefile [Timeout 660]
(rm -f ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.sim & ./ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Blocks.LimitersHomotopy.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.728510686953086]
Failed to read output from testmodel.py, exit status != 0:
['time', 'controllerFeedbackPart1.y', 'controllerFeedbackPart2.y', 'controllerFeedbackPart3.y', 'controllerFeedbackPart4.y', 'controllerFeedbackPart5.y', 'controllerFeedbackPart6.y', 'firstOrder1.y', 'firstOrder2.y', 'firstOrder3.y', 'firstOrder4.y', 'firstOrder5.y', 'firstOrder6.y']
0.32466267998097464 0.33384918699999994 0.319998093
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8d44622fb0>