Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.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.001986/0.001986, allocations: 100.4 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.001994/0.001994, allocations: 215.6 kB / 23.07 MB, free: 4.992 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.554/1.554, allocations: 230.6 MB / 256.9 MB, free: 7.738 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream 1.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream 1.2.0/package.mo): time 0.8305/0.8305, allocations: 94.62 MB / 407.9 MB, free: 8.816 MB / 318.1 MB
"
[Timeout remaining time 179]
Using package ThermofluidStream with version 1.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream 1.2.0/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.FlowControl.Tests.CheckValve,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="Time|pulse.T_start|pulse.count|source.outlet.m_flow",fileNamePrefix="ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve")
translateModel(ThermofluidStream.FlowControl.Tests.CheckValve,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="Time|pulse.T_start|pulse.count|source.outlet.m_flow",fileNamePrefix="ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.593e-05/2.593e-05, allocations: 2.281 kB / 0.5562 GB, free: 38.14 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(ThermofluidStream.FlowControl.Tests.CheckValve): time 0.1682/0.1682, allocations: 124 MB / 0.6773 GB, free: 12.38 MB / 0.5137 GB
Notification: Performance of NFInst.instExpressions: time 0.004888/0.1731, allocations: 3.307 MB / 0.6805 GB, free: 9.055 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004879/0.1736, allocations: 19.81 kB / 0.6806 GB, free: 9.035 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.0007899/0.1744, allocations: 162.9 kB / 0.6807 GB, free: 8.875 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.001187/0.1756, allocations: 381.8 kB / 0.6811 GB, free: 8.5 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0008596/0.1764, allocations: 295 kB / 0.6814 GB, free: 8.211 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.0008696/0.1773, allocations: 0.6109 MB / 0.682 GB, free: 7.598 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001909/0.1775, allocations: 57.97 kB / 0.682 GB, free: 7.531 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0006373/0.1781, allocations: 294.8 kB / 0.6823 GB, free: 7.242 MB / 0.5137 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003112/0.1784, allocations: 215 kB / 0.6825 GB, free: 7.031 MB / 0.5137 GB
Notification: Performance of NFPackage.collectConstants: time 5.391e-05/0.1785, allocations: 28 kB / 0.6825 GB, free: 7.004 MB / 0.5137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009806/0.1795, allocations: 459.2 kB / 0.683 GB, free: 6.555 MB / 0.5137 GB
Notification: Performance of combineBinaries: time 0.0007287/0.1802, allocations: 0.7692 MB / 0.6837 GB, free: 5.777 MB / 0.5137 GB
Notification: Performance of replaceArrayConstructors: time 0.0004065/0.1806, allocations: 0.5012 MB / 0.6842 GB, free: 5.27 MB / 0.5137 GB
Notification: Performance of NFVerifyModel.verify: time 7.766e-05/0.1807, allocations: 32 kB / 0.6842 GB, free: 5.238 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 0.0001147/0.1808, allocations: 31.86 kB / 0.6843 GB, free: 5.207 MB / 0.5137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 51 (48)
 * Number of variables: 51 (51)
Notification: Performance of [SIM] Bindings: time 0.00245/0.1832, allocations: 1.755 MB / 0.686 GB, free: 3.312 MB / 0.5137 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0003234/0.1836, allocations: 175.7 kB / 0.6861 GB, free: 3.133 MB / 0.5137 GB
Notification: Performance of [SIM] Early Inline: time 0.001093/0.1847, allocations: 0.7924 MB / 0.6869 GB, free: 2.312 MB / 0.5137 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004575/0.1851, allocations: 173.9 kB / 0.6871 GB, free: 2.09 MB / 0.5137 GB
Notification: Performance of [SIM] Alias: time 0.001587/0.1867, allocations: 1.005 MB / 0.6881 GB, free: 0.9414 MB / 0.5137 GB
Notification: Performance of [SIM] Simplify 2: time 0.0003783/0.1871, allocations: 162.5 kB / 0.6882 GB, free: 0.7383 MB / 0.5137 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001218/0.1872, allocations: 93.69 kB / 0.6883 GB, free: 0.6211 MB / 0.5137 GB
Notification: Performance of [SIM] Detect States: time 0.0003406/0.1875, allocations: 211.3 kB / 0.6885 GB, free: 368 kB / 0.5137 GB
Notification: Performance of [SIM] Events: time 0.0001104/0.1877, allocations: 66.2 kB / 0.6886 GB, free: 300 kB / 0.5137 GB
Notification: Performance of [SIM] Partitioning: time 0.0003204/0.188, allocations: 236 kB / 0.6888 GB, free: 60 kB / 0.5137 GB
Notification: Performance of [SIM] Causalize: time 0.0007742/0.1888, allocations: 0.5185 MB / 0.6893 GB, free: 15.53 MB / 0.5294 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0005002/0.1893, allocations: 467.6 kB / 0.6898 GB, free: 15.07 MB / 0.5294 GB
Notification: Performance of [INI] Simplify: time 0.000889/0.1901, allocations: 488.7 kB / 0.6902 GB, free: 14.52 MB / 0.5294 GB
Notification: Performance of [INI] Inline: time 0.0008535/0.191, allocations: 0.817 MB / 0.691 GB, free: 13.7 MB / 0.5294 GB
Notification: Performance of [INI] Partitioning: time 4.859e-05/0.191, allocations: 34.67 kB / 0.691 GB, free: 13.66 MB / 0.5294 GB
Notification: Performance of [INI] Cleanup: time 0.0001194/0.1912, allocations: 119.9 kB / 0.6912 GB, free: 13.54 MB / 0.5294 GB
Notification: Performance of [INI] Causalize: time 0.001227/0.1924, allocations: 0.8274 MB / 0.692 GB, free: 12.71 MB / 0.5294 GB
Notification: Performance of [INI] Tearing: time 9.08e-05/0.1925, allocations: 43.98 kB / 0.692 GB, free: 12.67 MB / 0.5294 GB
Notification: Performance of [SIM] Initialization: time 3.557e-06/0.1925, allocations: 8 kB / 0.692 GB, free: 12.66 MB / 0.5294 GB
Notification: Performance of [SIM] DAE-Mode: time 0.000367/0.1929, allocations: 174.9 kB / 0.6922 GB, free: 12.48 MB / 0.5294 GB
Notification: Performance of [SIM] Remove Dummies: time 8.816e-06/0.1929, allocations: 4 kB / 0.6922 GB, free: 12.48 MB / 0.5294 GB
Notification: Performance of [SIM] Tearing: time 6.124e-05/0.1929, allocations: 59.97 kB / 0.6922 GB, free: 12.42 MB / 0.5294 GB
Notification: Performance of [SIM] Categorize: time 8.897e-06/0.1929, allocations: 0 / 0.6922 GB, free: 12.42 MB / 0.5294 GB
Notification: Performance of [SIM] Solve: time 0.00115/0.1941, allocations: 0.5839 MB / 0.6928 GB, free: 11.84 MB / 0.5294 GB
Notification: Performance of [SIM] Jacobian: time 0.001588/0.1957, allocations: 1.205 MB / 0.694 GB, free: 10.49 MB / 0.5294 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: ............................. 1 (1) {checkValve.m_flow}
 * Number of discrete states: .................... 2 (2) {pulse.T_start, pulse.count}
 * 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: ........... 29 (scalar:29, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, 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: ........... 47 (scalar:47, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, 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: Performance of backend: time 6.432e-05/0.1957, allocations: 33.94 kB / 0.694 GB, free: 10.46 MB / 0.5294 GB
Notification: Performance of SimCode: time 0.003723/0.1995, allocations: 1.681 MB / 0.6957 GB, free: 8.762 MB / 0.5294 GB
Notification: Performance of Templates: time 0.01185/0.2113, allocations: 5.164 MB / 0.7007 GB, free: 3.629 MB / 0.5294 GB
"
[Timeout remaining time 660]
make -j1 -f ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.makefile [Timeout 660]
(rm -f ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.pipe ; mkfifo ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.pipe ; head -c 1048576 < ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.pipe >> ../files/ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.sim & ./ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve  -abortSlowSimulation -alarm=1200  -emit_protected -lv LOG_STATS > ThermofluidStream_ThermofluidStream.FlowControl.Tests.CheckValve.pipe 2>&1) [Timeout 1200]
[Calling os._exit(0), Time elapsed: 6.280286341032479]
Failed to read output from testmodel.py, exit status != 0:
0.21994727395940572 0.23638868500000002 0.052184318
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f2192666fb0>