Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.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.001425/0.001425, allocations: 104.3 kB / 19.72 MB, free: 2.145 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.001552/0.001552, allocations: 208.9 kB / 23 MB, free: 4.965 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.372/1.372, allocations: 230.6 MB / 256.8 MB, free: 7.801 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.866/2.866, allocations: 0.49 GB / 0.7958 GB, free: 35.35 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|enaDis.yOutDam_max|enaDis.yRetDam_min|enaDis.yRetDam_max|enaDis.andEnaDis.y|enaDis.truFalHol.y|freProSta1.y",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|enaDis.yOutDam_max|enaDis.yRetDam_min|enaDis.yRetDam_max|enaDis.andEnaDis.y|enaDis.truFalHol.y|freProSta1.y",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.539e-05/1.539e-05, allocations: 2.281 kB / 1.155 GB, free: 25.26 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta): time 0.00208/0.002095, allocations: 1.425 MB / 1.156 GB, free: 24.36 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.001817/0.003912, allocations: 1.736 MB / 1.158 GB, free: 23.11 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001117/0.004024, allocations: 9.438 kB / 1.158 GB, free: 23.11 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.0001203/0.004144, allocations: 40.7 kB / 1.158 GB, free: 23.08 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.0001187/0.004263, allocations: 66.56 kB / 1.158 GB, free: 23.03 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0005269/0.00479, allocations: 281 kB / 1.159 GB, free: 22.87 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.0004653/0.005255, allocations: 0.5743 MB / 1.159 GB, free: 22.58 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002339/0.005489, allocations: 165.7 kB / 1.159 GB, free: 22.48 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001861/0.005675, allocations: 219.4 kB / 1.159 GB, free: 22.36 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001749/0.00585, allocations: 227 kB / 1.16 GB, free: 22.24 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 7.979e-05/0.00593, allocations: 56.75 kB / 1.16 GB, free: 22.24 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001109/0.006041, allocations: 66.11 kB / 1.16 GB, free: 22.24 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.0004011/0.006442, allocations: 0.8121 MB / 1.161 GB, free: 21.67 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 0.0001776/0.006619, allocations: 471.3 kB / 1.161 GB, free: 21.34 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 7.137e-05/0.006691, allocations: 32.91 kB / 1.161 GB, free: 21.34 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 3.92e-05/0.00673, allocations: 31.81 kB / 1.161 GB, free: 21.32 MB / 0.9044 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 88 (88)
 * Number of variables: 88 (88)
Notification: Performance of [SIM] Bindings: time 0.001442/0.008171, allocations: 1.974 MB / 1.163 GB, free: 19.95 MB / 0.9044 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0001644/0.008336, allocations: 240.1 kB / 1.163 GB, free: 19.79 MB / 0.9044 GB
Notification: Performance of [SIM] Early Inline: time 0.001207/0.009542, allocations: 1.615 MB / 1.165 GB, free: 18.83 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 1: time 0.0003846/0.009927, allocations: 347.6 kB / 1.165 GB, free: 18.62 MB / 0.9044 GB
Notification: Performance of [SIM] Alias: time 0.002347/0.01227, allocations: 2.251 MB / 1.167 GB, free: 17.26 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 2: time 0.0002572/0.01253, allocations: 261.7 kB / 1.168 GB, free: 17.1 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001656/0.0127, allocations: 209 kB / 1.168 GB, free: 16.96 MB / 0.9044 GB
Notification: Performance of [SIM] Detect States: time 0.0004268/0.01312, allocations: 474.7 kB / 1.168 GB, free: 16.64 MB / 0.9044 GB
Notification: Performance of [SIM] Events: time 0.000246/0.01337, allocations: 192.6 kB / 1.168 GB, free: 16.54 MB / 0.9044 GB
Notification: Performance of [SIM] Partitioning: time 0.0003961/0.01377, allocations: 412 kB / 1.169 GB, free: 16.35 MB / 0.9044 GB
Notification: Performance of [SIM] Causalize: time 0.0008464/0.01461, allocations: 0.674 MB / 1.17 GB, free: 16.19 MB / 0.9044 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0007935/0.01541, allocations: 1.042 MB / 1.171 GB, free: 15.63 MB / 0.9044 GB
Notification: Performance of [INI] Simplify: time 0.001035/0.01644, allocations: 0.9026 MB / 1.171 GB, free: 15.12 MB / 0.9044 GB
Notification: Performance of [INI] Inline: time 0.001287/0.01773, allocations: 1.616 MB / 1.173 GB, free: 14.19 MB / 0.9044 GB
Notification: Performance of [INI] Partitioning: time 6.757e-05/0.01779, allocations: 42.78 kB / 1.173 GB, free: 14.16 MB / 0.9044 GB
Notification: Performance of [INI] Cleanup: time 0.0002106/0.01801, allocations: 278.8 kB / 1.173 GB, free: 14.01 MB / 0.9044 GB
Notification: Performance of [INI] Causalize: time 0.002754/0.02076, allocations: 2.32 MB / 1.176 GB, free: 13.42 MB / 0.9044 GB
Notification: Performance of [INI] Tearing: time 3.072e-05/0.02079, allocations: 54.88 kB / 1.176 GB, free: 13.38 MB / 0.9044 GB
Notification: Performance of [SIM] Initialization: time 6.52e-07/0.02079, allocations: 0 / 1.176 GB, free: 13.38 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Dummies: time 7.855e-06/0.0208, allocations: 448 / 1.176 GB, free: 13.38 MB / 0.9044 GB
Notification: Performance of [SIM] Tearing: time 1.135e-05/0.02081, allocations: 35.41 kB / 1.176 GB, free: 13.35 MB / 0.9044 GB
Notification: Performance of [SIM] Categorize: time 9.879e-06/0.02082, allocations: 6.203 kB / 1.176 GB, free: 13.35 MB / 0.9044 GB
Notification: Performance of [SIM] Solve: time 0.0005034/0.02132, allocations: 419 kB / 1.176 GB, free: 13.17 MB / 0.9044 GB
Notification: Performance of [SIM] Jacobian: time 8.396e-06/0.02133, allocations: 3.938 kB / 1.176 GB, free: 13.16 MB / 0.9044 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * 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: ............................. 0 (0) {}
 * Number of discrete states: .................... 8 (8) {booPul1.y, enaDis.delRetDam.y, enaDis.delRetDam.t_next, enaDis.and3.u2, enaDis.delOutDamOsc.t_next, enaDis.truFalHol.entryTimeFalse, enaDis.truFalHol.entryTimeTrue, enaDis.truFalHol.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 33 (33) {enaDis.truFalHol.u, enaDis.truFalHol.not_u, enaDis.truFalHol.not_y, enaDis.andEnaDis.y, enaDis.hysOutTem.y, enaDis.hysOutEnt.y, enaDis.outDamSwitch.u2, enaDis.maxRetDamSwitch.u2, enaDis.and1.y, enaDis.intEqu.y, enaDis.delOutDamOsc.u, enaDis.delRetDam.u, freProSta1.y, $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, $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: ........... 39 (scalar:39, array:0, record:0)
 * Number of multi strong components: ............ 8 (algorithm:0, when:8, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 102 (scalar:102, array:0, record:0)
 * Number of multi strong components: ............ 8 (algorithm:8, 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: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001122/0.02144, allocations: 55.73 kB / 1.176 GB, free: 13.13 MB / 0.9044 GB
Notification: Performance of SimCode: time 0.001577/0.02302, allocations: 1.439 MB / 1.178 GB, free: 12.51 MB / 0.9044 GB
Notification: Performance of Templates: time 0.008437/0.03146, allocations: 4.461 MB / 1.182 GB, free: 12.04 MB / 0.9044 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.pipe ; mkfifo Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.pipe ; head -c 1048576 < Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.pipe >> ../files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.sim & ./Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Controls_OBC_ASHRAE_G36_AHUs_MultiZone_VAV_Economizers_Subsequences_Validation_Enable_FreProSta.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Validation.Enable_FreProSta.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 7.669537059031427]