Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.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.001586/0.001586, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001914/0.001914, allocations: 209.5 kB / 23.06 MB, free: 4.984 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.519/1.519, allocations: 230.7 MB / 256.9 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream main/package.mo): time 0.9285/0.9285, allocations: 100.9 MB / 414.2 MB, free: 2.875 MB / 318.1 MB
"
[Timeout remaining time 179]
Using package ThermofluidStream with version 1.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream main/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(ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="Time|counterFlowNTU.h_out_A|counterFlowNTU.h_out_B|mCV.dp_int|mCV1.dp_int|sourceA.outlet.m_flow|sourceB.outlet.m_flow",fileNamePrefix="ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU")
translateModel(ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="Time|counterFlowNTU.h_out_A|counterFlowNTU.h_out_B|mCV.dp_int|mCV1.dp_int|sourceA.outlet.m_flow|sourceB.outlet.m_flow",fileNamePrefix="ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.314e-05/2.314e-05, allocations: 5.375 kB / 0.5653 GB, free: 35.43 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU): time 0.245/0.2451, allocations: 187.2 MB / 0.7482 GB, free: 4.82 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.4557/0.7007, allocations: 15.83 MB / 0.7636 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002141/0.7029, allocations: 75.59 kB / 0.7637 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.002293/0.7052, allocations: 0.5472 MB / 0.7643 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.007769/0.713, allocations: 1.786 MB / 0.766 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006032/0.719, allocations: 1.687 MB / 0.7676 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.004545/0.7235, allocations: 2.111 MB / 0.7697 GB, free: 3.984 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007869/0.7243, allocations: 172.9 kB / 0.7699 GB, free: 3.949 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004362/0.7287, allocations: 1.379 MB / 0.7712 GB, free: 3.945 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00165/0.7303, allocations: 0.5783 MB / 0.7718 GB, free: 3.945 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003236/0.7307, allocations: 98.77 kB / 0.7719 GB, free: 3.945 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008802/0.7395, allocations: 3.426 MB / 0.7752 GB, free: 3.879 MB / 0.5762 GB
Notification: Performance of combineBinaries: time 0.003394/0.7428, allocations: 2.661 MB / 0.7778 GB, free: 3.016 MB / 0.5762 GB
Notification: Performance of replaceArrayConstructors: time 0.001589/0.7444, allocations: 1.789 MB / 0.7796 GB, free: 1.902 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005663/0.745, allocations: 109.8 kB / 0.7797 GB, free: 1.902 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 0.0004429/0.7454, allocations: 114.7 kB / 0.7798 GB, free: 1.887 MB / 0.5762 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 227 (215)
 * Number of variables: 227 (227)
Notification: Performance of [SIM] Bindings: time 0.007361/0.7528, allocations: 6.077 MB / 0.7857 GB, free: 15.35 MB / 0.5919 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001155/0.754, allocations: 0.7001 MB / 0.7864 GB, free: 15.22 MB / 0.5919 GB
Notification: Performance of [SIM] Early Inline: time 0.004545/0.7585, allocations: 3.495 MB / 0.7898 GB, free: 15.11 MB / 0.5919 GB
Notification: Performance of [SIM] Simplify 1: time 0.001457/0.76, allocations: 0.529 MB / 0.7903 GB, free: 14.9 MB / 0.5919 GB
Notification: Performance of [SIM] Alias: time 0.006341/0.7663, allocations: 3.964 MB / 0.7942 GB, free: 13.76 MB / 0.5919 GB
Notification: Performance of [SIM] Simplify 2: time 0.0007916/0.7671, allocations: 421.5 kB / 0.7946 GB, free: 13.58 MB / 0.5919 GB
Notification: Performance of [SIM] Remove Stream: time 0.0003004/0.7674, allocations: 266.5 kB / 0.7949 GB, free: 13.49 MB / 0.5919 GB
Notification: Performance of [SIM] Detect States: time 0.000803/0.7682, allocations: 0.6385 MB / 0.7955 GB, free: 13.32 MB / 0.5919 GB
Notification: Performance of [SIM] Events: time 0.0002079/0.7684, allocations: 125.6 kB / 0.7956 GB, free: 13.32 MB / 0.5919 GB
Notification: Performance of [SIM] Partitioning: time 0.001167/0.7696, allocations: 1.069 MB / 0.7966 GB, free: 13.24 MB / 0.5919 GB
Notification: Performance of [SIM] Causalize: time 0.003531/0.7731, allocations: 2.539 MB / 0.7991 GB, free: 13.04 MB / 0.5919 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002212/0.7753, allocations: 2.241 MB / 0.8013 GB, free: 13.04 MB / 0.5919 GB
Notification: Performance of [INI] Simplify: time 0.002654/0.778, allocations: 1.258 MB / 0.8025 GB, free: 12.64 MB / 0.5919 GB
Notification: Performance of [INI] Inline: time 0.004132/0.7821, allocations: 3.545 MB / 0.806 GB, free: 12.61 MB / 0.5919 GB
Notification: Performance of [INI] Partitioning: time 0.0003215/0.7824, allocations: 63.78 kB / 0.8061 GB, free: 12.56 MB / 0.5919 GB
Notification: Performance of [INI] Cleanup: time 0.001025/0.7835, allocations: 0.5273 MB / 0.8066 GB, free: 12.56 MB / 0.5919 GB
Notification: Performance of [INI] Causalize: time 0.005962/0.7894, allocations: 3.453 MB / 0.8099 GB, free: 12.27 MB / 0.5919 GB
Notification: Performance of [INI] Tearing: time 0.0003832/0.7898, allocations: 225.9 kB / 0.8102 GB, free: 12.2 MB / 0.5919 GB
Notification: Performance of [SIM] Initialization: time 3.556e-06/0.7898, allocations: 0.9375 kB / 0.8102 GB, free: 12.2 MB / 0.5919 GB
Notification: Performance of [SIM] DAE-Mode: time 0.002061/0.7919, allocations: 1.097 MB / 0.8112 GB, free: 11.91 MB / 0.5919 GB
Notification: Performance of [SIM] Remove Dummies: time 2.131e-05/0.7919, allocations: 1.312 kB / 0.8112 GB, free: 11.91 MB / 0.5919 GB
Notification: Performance of [SIM] Tearing: time 0.0002746/0.7922, allocations: 274.1 kB / 0.8115 GB, free: 11.81 MB / 0.5919 GB
Notification: Performance of [SIM] Categorize: time 2.687e-05/0.7922, allocations: 4.562 kB / 0.8115 GB, free: 11.81 MB / 0.5919 GB
Notification: Performance of [SIM] Solve: time 0.007619/0.7998, allocations: 3.736 MB / 0.8151 GB, free: 11.41 MB / 0.5919 GB
Notification: Performance of [SIM] Jacobian: time 0.00572/0.8055, allocations: 3.886 MB / 0.8189 GB, free: 9.305 MB / 0.5919 GB
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: ......... 0
 * 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: ............................. 6 (6) {counterFlowNTU.h_out_A, counterFlowNTU.h_out_B, mCV.dp_int, counterFlowNTU.m_flow_B, mCV1.dp_int, counterFlowNTU.m_flow_A}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 3 (3) {$SEV_2, $SEV_1, $SEV_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: ........... 131 (scalar:131, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:4)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 3 (linear: 3, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 175 (scalar:175, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:4)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 3 (linear: 3, nonlinear:0)
Notification: Performance of backend: time 0.0001453/0.8057, allocations: 73.25 kB / 0.819 GB, free: 9.234 MB / 0.5919 GB
Notification: Performance of SimCode: time 0.01931/0.825, allocations: 7.191 MB / 0.826 GB, free: 7.043 MB / 0.5919 GB
Notification: Performance of Templates: time 0.04482/0.8698, allocations: 25.12 MB / 0.8506 GB, free: 6.254 MB / 0.6075 GB
"
[Timeout remaining time 659]
make -j1 -f ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.makefile [Timeout 660]
(rm -f ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.pipe ; mkfifo ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.pipe ; head -c 1048576 < ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.pipe >> ../files/ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.sim & ./ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU  -abortSlowSimulation -alarm=1200  -emit_protected -lv LOG_STATS > ThermofluidStream_dev_ThermofluidStream.HeatExchangers.Tests.CounterFlowNTU.pipe 2>&1) [Timeout 1200]
[Calling os._exit(0), Time elapsed: 7.681219910038635]
Failed to read output from testmodel.py, exit status != 0:
0.8780538480496034 0.894402379 0.145135975
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff2be9b6fb0>