Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.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.001562/0.001562, allocations: 100.4 kB / 19.72 MB, free: 2.121 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.001517/0.001517, allocations: 208.6 kB / 23.01 MB, free: 4.93 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.284/1.284, allocations: 230.6 MB / 256.8 MB, free: 7.789 MB / 206.1 MB
"
[Timeout remaining time 179]
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.742/2.742, allocations: 0.49 GB / 0.7958 GB, free: 35.42 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.ZoneGroups.Validation.ZoneStatusDuplicator,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|zonStaDup.yTZon.1|1.|zonStaDup.yTZon.1|2.|zonStaDup.yTZon.2|3.|zonStaDup.yTZon.2|4.|zonStaDup.yTZon.2|5.",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|zonStaDup.yTZon.1|1.|zonStaDup.yTZon.1|2.|zonStaDup.yTZon.2|3.|zonStaDup.yTZon.2|4.|zonStaDup.yTZon.2|5.",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.76e-05/1.76e-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.ZoneGroups.Validation.ZoneStatusDuplicator): time 0.001874/0.001891, allocations: 1.132 MB / 1.156 GB, free: 24.55 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.0004525/0.002344, allocations: 244.1 kB / 1.156 GB, free: 24.38 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 8.762e-05/0.002431, allocations: 20.47 kB / 1.156 GB, free: 24.37 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.0002179/0.002649, allocations: 122.5 kB / 1.156 GB, free: 24.3 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.0001883/0.002838, allocations: 71.44 kB / 1.157 GB, free: 24.27 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.000118/0.002956, allocations: 73.94 kB / 1.157 GB, free: 24.23 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.000429/0.003385, allocations: 417.9 kB / 1.157 GB, free: 24.07 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003887/0.003773, allocations: 318 kB / 1.157 GB, free: 23.92 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001471/0.00392, allocations: 186.2 kB / 1.157 GB, free: 23.85 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001833/0.004104, allocations: 212.2 kB / 1.158 GB, free: 23.75 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 6.619e-05/0.00417, allocations: 34.88 kB / 1.158 GB, free: 23.75 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 6.742e-05/0.004237, allocations: 34.81 kB / 1.158 GB, free: 23.75 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.0003681/0.004605, allocations: 0.611 MB / 1.158 GB, free: 23.34 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 0.0001935/0.004799, allocations: 394.6 kB / 1.159 GB, free: 23.09 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 5.441e-05/0.004853, allocations: 26.72 kB / 1.159 GB, free: 23.09 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 3.621e-05/0.00489, allocations: 23.06 kB / 1.159 GB, free: 23.07 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: 525 (122)
 * Number of variables: 525 (62)
Notification: Performance of [SIM] Bindings: time 0.001431/0.006321, allocations: 1.687 MB / 1.16 GB, free: 21.93 MB / 0.9044 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0003015/0.006622, allocations: 422.2 kB / 1.161 GB, free: 21.62 MB / 0.9044 GB
Notification: Performance of [SIM] Early Inline: time 0.0009729/0.007595, allocations: 1.235 MB / 1.162 GB, free: 20.98 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 1: time 0.0002724/0.007867, allocations: 247.8 kB / 1.162 GB, free: 20.8 MB / 0.9044 GB
Notification: Performance of [SIM] Alias: time 0.002645/0.01051, allocations: 2.48 MB / 1.165 GB, free: 19.53 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 2: time 0.0002189/0.01073, allocations: 200.4 kB / 1.165 GB, free: 19.38 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001508/0.01088, allocations: 135.1 kB / 1.165 GB, free: 19.27 MB / 0.9044 GB
Notification: Performance of [SIM] Detect States: time 0.0002786/0.01116, allocations: 273 kB / 1.165 GB, free: 19.04 MB / 0.9044 GB
Notification: Performance of [SIM] Events: time 3.213e-05/0.01119, allocations: 22.78 kB / 1.165 GB, free: 19.02 MB / 0.9044 GB
Notification: Performance of [SIM] Partitioning: time 0.0004635/0.01166, allocations: 443.7 kB / 1.166 GB, free: 18.84 MB / 0.9044 GB
Notification: Performance of [SIM] Causalize: time 0.002485/0.01414, allocations: 2.301 MB / 1.168 GB, free: 18.31 MB / 0.9044 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.000751/0.01489, allocations: 0.9026 MB / 1.169 GB, free: 17.89 MB / 0.9044 GB
Notification: Performance of [INI] Simplify: time 0.0004233/0.01531, allocations: 390.2 kB / 1.169 GB, free: 17.61 MB / 0.9044 GB
Notification: Performance of [INI] Inline: time 0.001055/0.01637, allocations: 1.374 MB / 1.171 GB, free: 16.96 MB / 0.9044 GB
Notification: Performance of [INI] Partitioning: time 3.575e-05/0.01641, allocations: 33.28 kB / 1.171 GB, free: 16.94 MB / 0.9044 GB
Notification: Performance of [INI] Cleanup: time 0.0001462/0.01655, allocations: 193 kB / 1.171 GB, free: 16.83 MB / 0.9044 GB
Notification: Performance of [INI] Causalize: time 0.00261/0.01916, allocations: 2.426 MB / 1.173 GB, free: 16.29 MB / 0.9044 GB
Notification: Performance of [INI] Tearing: time 2.552e-05/0.01919, allocations: 47.41 kB / 1.173 GB, free: 16.26 MB / 0.9044 GB
Notification: Performance of [SIM] Initialization: time 5.81e-07/0.01919, allocations: 1.156 kB / 1.173 GB, free: 16.26 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Dummies: time 5.41e-06/0.01919, allocations: 0.5 kB / 1.173 GB, free: 16.26 MB / 0.9044 GB
Notification: Performance of [SIM] Tearing: time 1.636e-05/0.01921, allocations: 52.31 kB / 1.173 GB, free: 16.22 MB / 0.9044 GB
Notification: Performance of [SIM] Categorize: time 7.755e-06/0.01922, allocations: 2.906 kB / 1.173 GB, free: 16.22 MB / 0.9044 GB
Notification: Performance of [SIM] Solve: time 0.0005448/0.01976, allocations: 360.4 kB / 1.174 GB, free: 16.07 MB / 0.9044 GB
Notification: Performance of [SIM] Jacobian: time 7.745e-06/0.01977, allocations: 1.375 kB / 1.174 GB, free: 16.07 MB / 0.9044 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 1
 * 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: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 180 (19) {zonStaDup.zonOcc, zonStaDup.u1Occ, zonStaDup.u1OccHeaHig, zonStaDup.u1HigOccCoo, zonStaDup.u1UnoHeaHig, zonStaDup.u1EndSetBac, zonStaDup.u1HigUnoCoo, zonStaDup.u1EndSetUp, zonStaDup.u1Win, zonStaDup.y1ZonOcc, zonStaDup.y1Occ, zonStaDup.y1OccHeaHig, zonStaDup.y1HigOccCoo, zonStaDup.y1UnoHeaHig, zonStaDup.y1EndSetBac, zonStaDup.y1HigUnoCoo, zonStaDup.y1EndSetUp, zonStaDup.y1Win, booInp.y}
 * 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: ........... 75 (scalar:75, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 17 (resizable: 17, 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: ........... 75 (scalar:75, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 17 (resizable: 17, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 4.899e-05/0.01982, allocations: 55.27 kB / 1.174 GB, free: 16.03 MB / 0.9044 GB
Notification: Performance of SimCode: time 0.004726/0.02454, allocations: 5.356 MB / 1.179 GB, free: 13.99 MB / 0.9044 GB
Notification: Performance of Templates: time 0.01023/0.03477, allocations: 4.596 MB / 1.183 GB, free: 13.37 MB / 0.9044 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.pipe ; mkfifo Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.pipe ; head -c 1048576 < Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.pipe >> ../files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.sim & ./Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Controls_OBC_ASHRAE_G36_ZoneGroups_Validation_ZoneStatusDuplicator.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
"Warning: Resultfile and Reference have different end time points!
Reffile[1]=0.000000
File[2502]=1.000000
Error: Could not read variable zonStaDup.yTZon[1 in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable zonStaDup.yTZon[1 from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable 1] in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable 1] from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable zonStaDup.yTZon[1 in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable zonStaDup.yTZon[1 from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable 2] in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable 2] from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable zonStaDup.yTZon[2 in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable zonStaDup.yTZon[2 from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable 3] in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable 3] from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable zonStaDup.yTZon[2 in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable zonStaDup.yTZon[2 from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable 4] in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable 4] from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable zonStaDup.yTZon[2 in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable zonStaDup.yTZon[2 from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
Error: Could not read variable 5] in file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat.
Warning: Get data of variable 5] from file Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.ZoneStatusDuplicator_res.mat failed!
"
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 7.244449254125357]