Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10.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.001619/0.001619, allocations: 96.38 kB / 21.25 MB, free: 0.5586 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.001789/0.001789, allocations: 206.1 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.517/1.517, allocations: 230.6 MB / 258.3 MB, free: 7.742 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo): time 1.333/1.333, allocations: 120.6 MB / 435.3 MB, free: 0.6367 MB / 334.1 MB
"
[Timeout remaining time 178]
Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/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(ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10,tolerance=1e-08,outputFormat="mat",numberOfIntervals=2500,variableFilter="QA.1.|QA.2.|QA.3.|QB.1.|QB.2.|QB.3.|TA.10.|TA.1.|TA.2.|TA.3.|TB.10.|TB.1.|TB.2.|TB.3.|TW.1.|TW.2.|TW.3.|der.TA.10..|der.TA.2..|der.TA.3..|der.TB.1..|der.TB.2..|der.TB.3..|der.TW.1..|der.TW.2..|der.TW.3..|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10")
translateModel(ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10,tolerance=1e-08,outputFormat="mat",numberOfIntervals=2500,variableFilter="QA.1.|QA.2.|QA.3.|QB.1.|QB.2.|QB.3.|TA.10.|TA.1.|TA.2.|TA.3.|TB.10.|TB.1.|TB.2.|TB.3.|TW.1.|TW.2.|TW.3.|der.TA.10..|der.TA.2..|der.TA.3..|der.TB.1..|der.TB.2..|der.TB.3..|der.TW.1..|der.TW.2..|der.TW.3..|time|time",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.205e-05/2.205e-05, allocations: 2.281 kB / 0.6095 GB, free: 8.719 MB / 446.3 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Thermal.HeatExchanger.ScaledExperiments.CounterCurrentHeatExchangerEquations_N_10): time 0.002149/0.002171, allocations: 1.428 MB / 0.6109 GB, free: 7.285 MB / 446.3 MB
Notification: Performance of NFInst.instExpressions: time 0.0002768/0.002448, allocations: 99.59 kB / 0.611 GB, free: 7.188 MB / 446.3 MB
Notification: Performance of NFInst.updateImplicitVariability: time 4.766e-05/0.002496, allocations: 0 / 0.611 GB, free: 7.188 MB / 446.3 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001132/0.002609, allocations: 11.92 kB / 0.611 GB, free: 7.176 MB / 446.3 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001149/0.002724, allocations: 67.7 kB / 0.6111 GB, free: 7.109 MB / 446.3 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0002012/0.002925, allocations: 39.81 kB / 0.6111 GB, free: 7.07 MB / 446.3 MB
Notification: Performance of NFFlatten.flatten: time 0.0001687/0.003094, allocations: 163.5 kB / 0.6113 GB, free: 6.91 MB / 446.3 MB
Notification: Performance of NFFlatten.resolveConnections: time 5.677e-05/0.003151, allocations: 4 kB / 0.6113 GB, free: 6.906 MB / 446.3 MB
Notification: Performance of NFEvalConstants.evaluate: time 8.851e-05/0.003239, allocations: 91.72 kB / 0.6114 GB, free: 6.816 MB / 446.3 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001097/0.003349, allocations: 83.72 kB / 0.6114 GB, free: 6.734 MB / 446.3 MB
Notification: Performance of NFPackage.collectConstants: time 2.75e-05/0.003376, allocations: 8 kB / 0.6115 GB, free: 6.727 MB / 446.3 MB
Notification: Performance of NFFlatten.collectFunctions: time 2.512e-05/0.003402, allocations: 4 kB / 0.6115 GB, free: 6.723 MB / 446.3 MB
Notification: Performance of combineBinaries: time 0.0001579/0.003559, allocations: 202.4 kB / 0.6116 GB, free: 6.523 MB / 446.3 MB
Notification: Performance of replaceArrayConstructors: time 5.142e-05/0.003611, allocations: 122.8 kB / 0.6118 GB, free: 6.402 MB / 446.3 MB
Notification: Performance of NFVerifyModel.verify: time 2.133e-05/0.003632, allocations: 4 kB / 0.6118 GB, free: 6.398 MB / 446.3 MB
Notification: Performance of FrontEnd: time 9.648e-06/0.003642, allocations: 4 kB / 0.6118 GB, free: 6.395 MB / 446.3 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 68 (12)
 * Number of variables: 68 (10)
Notification: Performance of [SIM] Bindings: time 0.000832/0.004474, allocations: 0.7804 MB / 0.6125 GB, free: 5.488 MB / 446.3 MB
Notification: Performance of [SIM] FunctionAlias: time 0.000123/0.004597, allocations: 87.89 kB / 0.6126 GB, free: 5.391 MB / 446.3 MB
Notification: Performance of [SIM] Early Inline: time 0.00023/0.004827, allocations: 379.9 kB / 0.613 GB, free: 4.992 MB / 446.3 MB
Notification: Performance of [SIM] Simplify 1: time 0.0001042/0.004931, allocations: 126 kB / 0.6131 GB, free: 4.824 MB / 446.3 MB
Notification: Performance of [SIM] Alias: time 0.0004071/0.005338, allocations: 310.2 kB / 0.6134 GB, free: 4.457 MB / 446.3 MB
Notification: Performance of [SIM] Simplify 2: time 9.13e-05/0.00543, allocations: 125.9 kB / 0.6135 GB, free: 4.285 MB / 446.3 MB
Notification: Performance of [SIM] Remove Stream: time 4.152e-05/0.005471, allocations: 60.41 kB / 0.6136 GB, free: 4.199 MB / 446.3 MB
Notification: Performance of [SIM] Detect States: time 0.0001579/0.005629, allocations: 164.6 kB / 0.6137 GB, free: 3.988 MB / 446.3 MB
Notification: Performance of [SIM] Events: time 6.182e-05/0.005691, allocations: 27.98 kB / 0.6138 GB, free: 3.961 MB / 446.3 MB
Notification: Performance of [SIM] Partitioning: time 0.0001368/0.005828, allocations: 135.9 kB / 0.6139 GB, free: 3.82 MB / 446.3 MB
Notification: Performance of [SIM] Causalize: time 0.0006309/0.006458, allocations: 0.6661 MB / 0.6145 GB, free: 3.141 MB / 446.3 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0001741/0.006633, allocations: 327.5 kB / 0.6148 GB, free: 2.82 MB / 446.3 MB
Notification: Performance of [INI] Simplify: time 0.0002311/0.006864, allocations: 224.8 kB / 0.6151 GB, free: 2.535 MB / 446.3 MB
Notification: Performance of [INI] Inline: time 0.0002656/0.007129, allocations: 495.3 kB / 0.6155 GB, free: 2.047 MB / 446.3 MB
Notification: Performance of [INI] Partitioning: time 1.332e-05/0.007143, allocations: 12.12 kB / 0.6155 GB, free: 2.027 MB / 446.3 MB
Notification: Performance of [INI] Cleanup: time 4.15e-05/0.007184, allocations: 63.92 kB / 0.6156 GB, free: 1.965 MB / 446.3 MB
Notification: Performance of [INI] Causalize: time 0.0009239/0.008108, allocations: 0.9737 MB / 0.6166 GB, free: 0.9609 MB / 446.3 MB
Notification: Performance of [INI] Tearing: time 1.314e-05/0.008121, allocations: 12 kB / 0.6166 GB, free: 0.9492 MB / 446.3 MB
Notification: Performance of [SIM] Initialization: time 3.51e-07/0.008121, allocations: 4 kB / 0.6166 GB, free: 0.9453 MB / 446.3 MB
Notification: Performance of [SIM] DAE-Mode: time 4.774e-05/0.008169, allocations: 28.11 kB / 0.6166 GB, free: 0.9102 MB / 446.3 MB
Notification: Performance of [SIM] Remove Dummies: time 4.258e-06/0.008173, allocations: 0 / 0.6166 GB, free: 0.9102 MB / 446.3 MB
Notification: Performance of [SIM] Tearing: time 5.992e-06/0.008179, allocations: 16 kB / 0.6166 GB, free: 0.8945 MB / 446.3 MB
Notification: Performance of [SIM] Categorize: time 5.891e-06/0.008185, allocations: 0 / 0.6166 GB, free: 0.8945 MB / 446.3 MB
Notification: Performance of [SIM] Solve: time 0.0003248/0.00851, allocations: 255.9 kB / 0.6169 GB, free: 0.6445 MB / 446.3 MB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref QB[1] is neither a seed nor a partial candidate!
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 4.358122416015249]
Failed to read output from testmodel.py, exit status != 0:
0.016315345012117177 0.031534044000000004 0.024924279
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f016a7b2dd0>