Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.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.001789/0.001789, allocations: 80.88 kB / 21.56 MB, free: 2.934 MB / 18.57 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.001941/0.001941, allocations: 164 kB / 24.97 MB, free: 8.672 MB / 18.57 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.644/1.644, allocations: 177.1 MB / 205.4 MB, free: 5.469 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 3.319/3.319, allocations: 389.5 MB / 0.6361 GB, free: 12.34 MB / 0.6042 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/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(Buildings.Examples.VAVCO2.VAVSystemCTControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl")
translateModel(Buildings.Examples.VAVCO2.VAVSystemCTControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.213e-05/2.213e-05, allocations: 2.312 kB / 0.7759 GB, free: 5.41 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.VAVCO2.VAVSystemCTControl): time 0.39/0.39, allocations: 267.7 MB / 1.037 GB, free: 8.953 MB / 0.9948 GB
Notification: Performance of NFInst.instExpressions: time 0.7491/1.139, allocations: 54.53 MB / 1.091 GB, free: 31.87 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02741/1.166, allocations: 1.058 MB / 1.092 GB, free: 31.87 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.01652/1.183, allocations: 5.422 MB / 1.097 GB, free: 31.8 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.04394/1.227, allocations: 15.8 MB / 1.112 GB, free: 30.2 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03138/1.258, allocations: 13.47 MB / 1.125 GB, free: 29.92 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.08326/1.342, allocations: 69.18 MB / 1.193 GB, free: 1.812 MB / 1.01 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0568/1.398, allocations: 19.5 MB / 1.212 GB, free: 4.43 MB / 1.026 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.08008/1.478, allocations: 29.22 MB / 1.241 GB, free: 14.26 MB / 1.057 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03096/1.509, allocations: 13.21 MB / 1.253 GB, free: 2.453 MB / 1.057 GB
Notification: Performance of NFPackage.collectConstants: time 0.01023/1.52, allocations: 2.711 MB / 1.256 GB, free: 15.74 MB / 1.073 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02382/1.543, allocations: 6.457 MB / 1.262 GB, free: 9.586 MB / 1.073 GB
Notification: Performance of combineBinaries: time 0.08091/1.624, allocations: 42.06 MB / 1.304 GB, free: 2.246 MB / 1.104 GB
Notification: Performance of replaceArrayConstructors: time 0.03789/1.662, allocations: 22.32 MB / 1.325 GB, free: 13.05 MB / 1.135 GB
Notification: Performance of NFVerifyModel.verify: time 0.01626/1.679, allocations: 1.711 MB / 1.327 GB, free: 11.34 MB / 1.135 GB
Notification: Performance of FrontEnd: time 0.005749/1.684, allocations: 0.6558 MB / 1.328 GB, free: 10.8 MB / 1.135 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3076 (2859)
 * Number of variables: 3076 (2615)
Notification: Performance of [SIM] Bindings: time 0.252/1.936, allocations: 114.3 MB / 1.439 GB, free: 13.55 MB / 1.245 GB
Notification: Performance of [SIM] FunctionAlias: time 0.04676/1.983, allocations: 21.42 MB / 1.46 GB, free: 9.168 MB / 1.26 GB
Notification: Performance of [SIM] Early Inline: time 1.481/3.464, allocations: 94.72 MB / 1.553 GB, free: 229.6 MB / 1.339 GB
Notification: Performance of [SIM] Simplify 1: time 0.0222/3.486, allocations: 7.019 MB / 1.56 GB, free: 228.2 MB / 1.339 GB
Warning: NBAlias.selectStartByConfidence: Alias set with conflicting unfixed start values of equal confidence detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.1487/3.635, allocations: 75.77 MB / 1.634 GB, free: 215.2 MB / 1.339 GB
Notification: Performance of [SIM] Simplify 2: time 0.01605/3.651, allocations: 5.63 MB / 1.639 GB, free: 214.2 MB / 1.339 GB
Notification: Performance of [SIM] Remove Stream: time 0.01445/3.666, allocations: 6.817 MB / 1.646 GB, free: 213.2 MB / 1.339 GB
Notification: Performance of [SIM] Detect States: time 0.02825/3.694, allocations: 15.86 MB / 1.661 GB, free: 211.8 MB / 1.339 GB
Notification: Performance of [SIM] Events: time 0.01002/3.704, allocations: 5.712 MB / 1.667 GB, free: 211.3 MB / 1.339 GB
Notification: Performance of [SIM] Partitioning: time 0.05499/3.759, allocations: 20.1 MB / 1.686 GB, free: 202.8 MB / 1.339 GB
Notification: Performance of [SIM] Causalize: time 0.06714/3.826, allocations: 29.97 MB / 1.716 GB, free: 193.8 MB / 1.339 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.06802/3.894, allocations: 46.67 MB / 1.761 GB, free: 162 MB / 1.339 GB
Notification: Performance of [INI] Simplify: time 0.09858/3.993, allocations: 48.36 MB / 1.808 GB, free: 134.8 MB / 1.339 GB
Notification: Performance of [INI] Inline: time 0.1371/4.13, allocations: 92.18 MB / 1.898 GB, free: 47.25 MB / 1.339 GB
Notification: Performance of [INI] Partitioning: time 0.003679/4.133, allocations: 0.9089 MB / 1.899 GB, free: 46.23 MB / 1.339 GB
Notification: Performance of [INI] Cleanup: time 0.03142/4.165, allocations: 20.97 MB / 1.92 GB, free: 26.21 MB / 1.339 GB
Notification: Performance of [INI] Causalize: time 0.3482/4.513, allocations: 129.9 MB / 2.047 GB, free: 12.36 MB / 1.448 GB
Notification: Performance of [INI] Tearing: time 0.7209/5.234, allocations: 13.61 MB / 2.06 GB, free: 277.1 MB / 1.448 GB
Notification: Performance of [SIM] Initialization: time 4.208e-06/5.234, allocations: 0.5625 kB / 2.06 GB, free: 277.1 MB / 1.448 GB
Notification: Performance of [SIM] Remove Dummies: time 0.0002747/5.234, allocations: 30.77 kB / 2.06 GB, free: 277.1 MB / 1.448 GB
Notification: Performance of [SIM] Tearing: time 0.01083/5.245, allocations: 6.665 MB / 2.067 GB, free: 276.1 MB / 1.448 GB
Notification: Performance of [SIM] Categorize: time 0.0001586/5.245, allocations: 67.69 kB / 2.067 GB, free: 276.1 MB / 1.448 GB
Notification: Performance of [SIM] Solve: time 0.08391/5.329, allocations: 34.91 MB / 2.101 GB, free: 275 MB / 1.448 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:800:5-800:70:writable] Warning: Variable t of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:801:5-801:57:writable] Warning: Variable h00 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:802:5-802:57:writable] Warning: Variable h10 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:803:5-803:57:writable] Warning: Variable h01 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:804:5-804:57:writable] Warning: Variable h11 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:805:5-805:23:writable] Warning: Variable aux3 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:806:5-806:25:writable] Warning: Variable aux2 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:800:5-800:70:writable] Warning: Variable $fDER_t of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:801:5-801:57:writable] Warning: Variable $fDER_h00 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:802:5-802:57:writable] Warning: Variable $fDER_h10 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:803:5-803:57:writable] Warning: Variable $fDER_h01 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:804:5-804:57:writable] Warning: Variable $fDER_h11 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:805:5-805:23:writable] Warning: Variable $fDER_aux3 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:806:5-806:25:writable] Warning: Variable $fDER_aux2 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
Notification: Performance of [SIM] Jacobian: time 0.07707/5.406, allocations: 35.27 MB / 2.135 GB, free: 267.8 MB / 1.448 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 0.0001669/5.406, allocations: 0 / 2.135 GB, free: 267.8 MB / 1.448 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 41
 * 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: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 63 (63) {roo.roo45.vav.y_filtered, roo.roo45.vol.U, roo.roo45.vol.dynBal.m, roo.roo45.vol.Xi, roo.roo45.vol.mC, roo.roo45.ple.U, roo.roo45.ple.dynBal.m, roo.roo45.ple.Xi, roo.roo45.ple.mC, roo.roo46.vav.y_filtered, roo.roo46.vol.U, roo.roo46.vol.dynBal.m, roo.roo46.vol.Xi, roo.roo46.vol.mC, roo.roo46.ple.U, roo.roo46.ple.dynBal.m, roo.roo46.ple.Xi, roo.roo46.ple.mC, roo.roo47.vav.y_filtered, roo.roo47.vol.U, roo.roo47.vol.dynBal.m, roo.roo47.vol.Xi, roo.roo47.vol.mC, roo.roo47.ple.U, roo.roo47.ple.dynBal.m, roo.roo47.ple.Xi, roo.roo47.ple.mC, roo.roo48.vav.y_filtered, roo.roo48.vol.U, roo.roo48.vol.dynBal.m, roo.roo48.vol.Xi, roo.roo48.vol.mC, roo.roo48.ple.U, roo.roo48.ple.dynBal.m, roo.roo48.ple.Xi, roo.roo48.ple.mC, roo.roo49.vav.y_filtered, roo.roo49.vol.U, roo.roo49.vol.dynBal.m, roo.roo49.vol.Xi, roo.roo49.vol.mC, roo.roo49.ple.U, roo.roo49.ple.dynBal.m, roo.roo49.ple.Xi, roo.roo49.ple.mC, roo.roo50.vav.y_filtered, roo.roo50.vol.U, roo.roo50.vol.dynBal.m, roo.roo50.vol.Xi, roo.roo50.vol.mC, roo.roo50.ple.U, roo.roo50.ple.dynBal.m, roo.roo50.ple.Xi, roo.roo50.ple.mC, fan32.vol.U, fan32.vol.dynBal.m, fan32.vol.Xi, fan32.vol.mC, fan56.vol.U, fan56.vol.dynBal.m, fan56.vol.Xi, fan56.vol.mC, dp32.u}
 * Number of discrete states: .................... 13 (13) {onSig.pulseStart, roo.occ.smaRoo2.nextTimeEvent, roo.occ.smaRoo2.nextTimeEventScaled, roo.occ.smaRoo1.nextTimeEvent, roo.occ.smaRoo1.nextTimeEventScaled, roo.occ.cla2.nextTimeEvent, roo.occ.cla2.nextTimeEventScaled, roo.occ.cla1.nextTimeEvent, roo.occ.cla1.nextTimeEventScaled, roo.occ.office2.nextTimeEvent, roo.occ.office2.nextTimeEventScaled, roo.occ.office1.nextTimeEvent, roo.occ.office1.nextTimeEventScaled}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 24 (24) {booToRea.u, $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_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: ........... 1825 (scalar:1733, array:92, record:0)
 * Number of multi strong components: ............ 13 (algorithm:0, when:13, if:0, tuple:0)
 * Number of for-loop strong components: ......... 74 (resizable: 74, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 11 (linear: 0, nonlinear:11)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 2211 (scalar:1983, array:228, record:0)
 * Number of multi strong components: ............ 12 (algorithm:12, when:0, if:0, tuple:12)
 * Number of for-loop strong components: ......... 98 (resizable: 98, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 11 (linear: 0, nonlinear:11)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 2269 (scalar:2041, array:228, record:0)
 * Number of multi strong components: ............ 12 (algorithm:12, when:0, if:0, tuple:12)
 * Number of for-loop strong components: ......... 98 (resizable: 98, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 3 (linear: 2, nonlinear:1)
Notification: Performance of backend: time 0.002436/5.409, allocations: 0.9005 MB / 2.136 GB, free: 266.9 MB / 1.448 GB
Notification: Performance of SimCode: time 0.1657/5.574, allocations: 74.75 MB / 2.209 GB, free: 249.5 MB / 1.448 GB
Notification: Performance of Templates: time 0.379/5.953, allocations: 252.4 MB / 2.456 GB, free: 67.41 MB / 1.448 GB
"
[Timeout remaining time 294]
make -j1 -f Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe ; mkfifo Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe ; head -c 1048576 < Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe >> ../files/Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.sim & ./Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 265.15792378783226]