Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.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.001809/0.001809, 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.002252/0.002252, 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.562/1.562, allocations: 230.7 MB / 256.9 MB, free: 7.777 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.8676/0.8676, allocations: 94.63 MB / 407.9 MB, free: 8.898 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.Undirected.FlowControl.Tests.MCV,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="Time|boundaryFore10.rear.m_flow|boundaryFore11.rear.m_flow|boundaryFore6.rear.m_flow|boundaryFore7.rear.m_flow|boundaryFore8.rear.m_flow|boundaryRear.fore.m_flow|boundaryRear2.fore.m_flow|boundaryRear3.fore.m_flow|boundaryRear6.fore.m_flow|boundaryRear7.fore.m_flow|mCV.dp_int|mCV1.dp_int|mCV2.dp_int|mCV3.dp_int|mCV4.dp_int|mCV5.dp_int|mCV6.dp_int|mCV7.dp_int|mCV8.dp_int|mCV9.dp_int|pulse1.T_start|pulse1.count|pulse3.T_start|pulse3.count|pulse5.T_start|pulse5.count|trapezoid.T_start|trapezoid.count|trapezoid1.T_start|trapezoid1.count|trapezoid2.T_start|trapezoid2.count",fileNamePrefix="ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV") translateModel(ThermofluidStream.Undirected.FlowControl.Tests.MCV,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="Time|boundaryFore10.rear.m_flow|boundaryFore11.rear.m_flow|boundaryFore6.rear.m_flow|boundaryFore7.rear.m_flow|boundaryFore8.rear.m_flow|boundaryRear.fore.m_flow|boundaryRear2.fore.m_flow|boundaryRear3.fore.m_flow|boundaryRear6.fore.m_flow|boundaryRear7.fore.m_flow|mCV.dp_int|mCV1.dp_int|mCV2.dp_int|mCV3.dp_int|mCV4.dp_int|mCV5.dp_int|mCV6.dp_int|mCV7.dp_int|mCV8.dp_int|mCV9.dp_int|pulse1.T_start|pulse1.count|pulse3.T_start|pulse3.count|pulse5.T_start|pulse5.count|trapezoid.T_start|trapezoid.count|trapezoid1.T_start|trapezoid1.count|trapezoid2.T_start|trapezoid2.count",fileNamePrefix="ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.242e-05/2.242e-05, allocations: 7.062 kB / 0.5562 GB, free: 38.1 MB / 446.1 MB Notification: Performance of NFInst.instantiate(ThermofluidStream.Undirected.FlowControl.Tests.MCV): time 0.6724/0.6724, allocations: 204 MB / 0.7554 GB, free: 3.586 MB / 0.5762 GB Notification: Performance of NFInst.instExpressions: time 0.03817/0.7106, allocations: 26.04 MB / 0.7808 GB, free: 3.488 MB / 0.5762 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.006295/0.7169, allocations: 215 kB / 0.7811 GB, free: 3.488 MB / 0.5762 GB Notification: Performance of NFTyping.typeComponents: time 0.006728/0.7236, allocations: 1.693 MB / 0.7827 GB, free: 3.449 MB / 0.5762 GB Notification: Performance of NFTyping.typeBindings: time 0.01665/0.7402, allocations: 4.503 MB / 0.7871 GB, free: 3.324 MB / 0.5762 GB Notification: Performance of NFTyping.typeClassSections: time 0.01261/0.7528, allocations: 3.307 MB / 0.7903 GB, free: 3.262 MB / 0.5762 GB Notification: Performance of NFFlatten.flatten: time 0.01833/0.7712, allocations: 8.243 MB / 0.7984 GB, free: 3.234 MB / 0.5762 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003982/0.7752, allocations: 0.5785 MB / 0.7989 GB, free: 19.06 MB / 0.5919 GB Notification: Performance of NFEvalConstants.evaluate: time 0.01311/0.7883, allocations: 3.723 MB / 0.8026 GB, free: 19.04 MB / 0.5919 GB Notification: Performance of NFSimplifyModel.simplify: time 0.007418/0.7957, allocations: 3.059 MB / 0.8056 GB, free: 18.46 MB / 0.5919 GB Notification: Performance of NFPackage.collectConstants: time 0.002131/0.7978, allocations: 342 kB / 0.8059 GB, free: 18.46 MB / 0.5919 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01421/0.812, allocations: 4.545 MB / 0.8103 GB, free: 18.36 MB / 0.5919 GB Notification: Performance of combineBinaries: time 0.01392/0.8259, allocations: 9.334 MB / 0.8195 GB, free: 13.71 MB / 0.5919 GB Notification: Performance of replaceArrayConstructors: time 0.008612/0.8345, allocations: 6.163 MB / 0.8255 GB, free: 9.93 MB / 0.5919 GB Notification: Performance of NFVerifyModel.verify: time 0.003442/0.838, allocations: 415.8 kB / 0.8259 GB, free: 9.93 MB / 0.5919 GB Notification: Performance of FrontEnd: time 0.001325/0.8393, allocations: 385.1 kB / 0.8262 GB, free: 9.879 MB / 0.5919 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 847 (795) * Number of variables: 847 (847) Notification: Performance of [SIM] Bindings: time 0.0371/0.8764, allocations: 21.41 MB / 0.8471 GB, free: 1.367 MB / 0.5919 GB Notification: Performance of [SIM] FunctionAlias: time 0.006382/0.8828, allocations: 2.754 MB / 0.8498 GB, free: 0.957 MB / 0.5919 GB Notification: Performance of [SIM] Early Inline: time 0.03302/0.9158, allocations: 17.88 MB / 0.8673 GB, free: 4.332 MB / 0.6075 GB Notification: Performance of [SIM] Simplify 1: time 0.007804/0.9236, allocations: 2.421 MB / 0.8697 GB, free: 1.844 MB / 0.6075 GB Notification: Performance of [SIM] Alias: time 0.02987/0.9535, allocations: 15.51 MB / 0.8848 GB, free: 1.109 MB / 0.6231 GB Notification: Performance of [SIM] Simplify 2: time 0.005064/0.9586, allocations: 2.285 MB / 0.887 GB, free: 14.72 MB / 0.6387 GB Notification: Performance of [SIM] Remove Stream: time 0.002815/0.9614, allocations: 1.272 MB / 0.8883 GB, free: 13.38 MB / 0.6387 GB Notification: Performance of [SIM] Detect States: time 0.005363/0.9667, allocations: 3.284 MB / 0.8915 GB, free: 10.04 MB / 0.6387 GB Notification: Performance of [SIM] Events: time 0.004071/0.9708, allocations: 1.825 MB / 0.8933 GB, free: 8.27 MB / 0.6387 GB Notification: Performance of [SIM] Partitioning: time 0.0154/0.9862, allocations: 5.861 MB / 0.899 GB, free: 2.383 MB / 0.6387 GB Notification: Performance of [SIM] Causalize: time 0.02118/1.007, allocations: 11.61 MB / 0.9103 GB, free: 6.887 MB / 0.6544 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.0171/1.024, allocations: 11.47 MB / 0.9215 GB, free: 11.48 MB / 0.67 GB Notification: Performance of [INI] Simplify: time 0.01355/1.038, allocations: 5.842 MB / 0.9272 GB, free: 5.52 MB / 0.67 GB Notification: Performance of [INI] Inline: time 0.02946/1.067, allocations: 19.65 MB / 0.9464 GB, free: 1.996 MB / 0.6856 GB Notification: Performance of [INI] Partitioning: time 0.001541/1.069, allocations: 269.2 kB / 0.9467 GB, free: 1.688 MB / 0.6856 GB Notification: Performance of [INI] Cleanup: time 0.006665/1.076, allocations: 2.877 MB / 0.9495 GB, free: 14.85 MB / 0.7012 GB Notification: Performance of [INI] Causalize: time 0.04456/1.12, allocations: 17.47 MB / 0.9666 GB, free: 13.33 MB / 0.7169 GB Notification: Performance of [INI] Tearing: time 0.0008983/1.121, allocations: 0.6958 MB / 0.9672 GB, free: 12.64 MB / 0.7169 GB Notification: Performance of [SIM] Initialization: time 1.663e-06/1.121, allocations: 0 / 0.9672 GB, free: 12.64 MB / 0.7169 GB Notification: Performance of [SIM] DAE-Mode: time 0.008843/1.13, allocations: 5.021 MB / 0.9721 GB, free: 7.766 MB / 0.7169 GB Notification: Performance of [SIM] Remove Dummies: time 0.0001172/1.13, allocations: 17.5 kB / 0.9722 GB, free: 7.746 MB / 0.7169 GB Notification: Performance of [SIM] Tearing: time 0.0009084/1.131, allocations: 0.8923 MB / 0.973 GB, free: 6.871 MB / 0.7169 GB Notification: Performance of [SIM] Categorize: time 0.0001143/1.131, allocations: 30.53 kB / 0.9731 GB, free: 6.844 MB / 0.7169 GB Notification: Performance of [SIM] Solve: time 0.03543/1.167, allocations: 19.74 MB / 0.9923 GB, free: 3.301 MB / 0.7325 GB Notification: Performance of [SIM] Jacobian: time 0.02081/1.187, allocations: 14.46 MB / 1.006 GB, free: 3.527 MB / 0.7481 GB Notification: Partition statistics after passing the back-end: * Number of ODE partitions: ..................... 0 * Number of algebraic partitions: ............... 0 * Number of ODE event partitions: ............... 10 * 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: ............................. 20 (20) {mCV.dp_int, mCV1.dp_int, mCV2.dp_int, mCV3.dp_int, mCV4.dp_int, mCV5.dp_int, mCV5.m_flow, mCV.m_flow, mCV1.m_flow, mCV2.m_flow, mCV3.m_flow, mCV4.m_flow, mCV6.dp_int, mCV6.m_flow, mCV7.dp_int, mCV7.m_flow, mCV8.dp_int, mCV8.m_flow, mCV9.dp_int, mCV9.m_flow} * Number of discrete states: .................... 12 (12) {trapezoid2.T_start, trapezoid2.count, pulse5.T_start, pulse5.count, trapezoid1.T_start, trapezoid1.count, pulse3.T_start, pulse3.count, trapezoid.T_start, trapezoid.count, pulse1.T_start, pulse1.count} * Number of clocked states: ..................... 0 (0) {} * Number of discrete variables: ................. 132 (132) {$SEV_131, $SEV_130, $SEV_129, $SEV_128, $SEV_127, $SEV_126, $SEV_125, $SEV_124, $SEV_123, $SEV_122, $SEV_121, $SEV_120, $SEV_119, $SEV_118, $SEV_117, $SEV_116, $SEV_115, $SEV_114, $SEV_113, $SEV_112, $SEV_111, $SEV_110, $SEV_109, $SEV_108, $SEV_107, $SEV_106, $SEV_105, $SEV_104, $SEV_103, $SEV_102, $SEV_101, $SEV_100, $SEV_99, $SEV_98, $SEV_97, $SEV_96, $SEV_95, $SEV_94, $SEV_93, $SEV_92, $SEV_91, $SEV_90, $SEV_89, $SEV_88, $SEV_87, $SEV_86, $SEV_85, $SEV_84, $SEV_83, $SEV_82, $SEV_81, $SEV_80, $SEV_79, $SEV_78, $SEV_77, $SEV_76, $SEV_75, $SEV_74, $SEV_73, $SEV_72, $SEV_71, $SEV_70, $SEV_69, $SEV_68, $SEV_67, $SEV_66, $SEV_65, $SEV_64, $SEV_63, $SEV_62, $SEV_61, $SEV_60, $SEV_59, $SEV_58, $SEV_57, $SEV_56, $SEV_55, $SEV_54, $SEV_53, $SEV_52, $SEV_51, $SEV_50, $SEV_49, $SEV_48, $SEV_47, $SEV_46, $SEV_45, $SEV_44, $SEV_43, $SEV_42, $SEV_41, $SEV_40, $SEV_39, $SEV_38, $SEV_37, $SEV_36, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $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} * 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: ........... 677 (scalar:677, array:0, record:0) * Number of multi strong components: ............ 12 (algorithm:0, when:12, if:0, tuple:0) * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0) * Number of algebraic-loop strong components: ... 10 (linear: 10, nonlinear:0) Notification: [Initialization] Strong Component statistics after passing the back-end: * Number of single strong components: ........... 884 (scalar:884, array:0, record:0) * Number of multi strong components: ............ 6 (algorithm:6, 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: ... 10 (linear: 10, nonlinear:0) Notification: Performance of backend: time 0.000636/1.188, allocations: 267.3 kB / 1.007 GB, free: 3.27 MB / 0.7481 GB Notification: Performance of SimCode: time 0.5061/1.694, allocations: 22.36 MB / 1.029 GB, free: 134 MB / 0.7637 GB Notification: Performance of Templates: time 0.1347/1.829, allocations: 86.89 MB / 1.113 GB, free: 105.6 MB / 0.7637 GB " [Timeout remaining time 658] make -j1 -f ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.makefile [Timeout 660] (rm -f ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.pipe ; mkfifo ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.pipe ; head -c 1048576 < ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.pipe >> ../files/ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.sim & ./ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV -abortSlowSimulation -alarm=1200 -emit_protected -lv LOG_STATS > ThermofluidStream_ThermofluidStream.Undirected.FlowControl.Tests.MCV.pipe 2>&1) [Timeout 1200] [Calling os._exit(0), Time elapsed: 11.874763974978123] Failed to read output from testmodel.py, exit status != 0: 1.837268078001216 1.848402677 1.005858455 Calling exit ...