Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.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.00183/0.00183, 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.001889/0.001889, allocations: 159 kB / 24.97 MB, free: 8.75 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.542/1.542, allocations: 177.1 MB / 205.4 MB, free: 4.449 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.358/3.358, allocations: 389.5 MB / 0.6361 GB, free: 13.38 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.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.701e-05/3.701e-05, allocations: 5.969 kB / 0.7761 GB, free: 13.83 MB / 0.7448 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP): time 0.01143/0.01147, allocations: 5.308 MB / 0.7813 GB, free: 8.496 MB / 0.7448 GB
Notification: Performance of NFInst.instExpressions: time 0.008638/0.0201, allocations: 3.013 MB / 0.7842 GB, free: 5.461 MB / 0.7448 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002662/0.02277, allocations: 63.62 kB / 0.7843 GB, free: 5.398 MB / 0.7448 GB
Notification: Performance of NFTyping.typeComponents: time 0.001546/0.02431, allocations: 324.5 kB / 0.7846 GB, free: 5.078 MB / 0.7448 GB
Notification: Performance of NFTyping.typeBindings: time 0.002206/0.02652, allocations: 317 kB / 0.7849 GB, free: 4.766 MB / 0.7448 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00339/0.02991, allocations: 0.78 MB / 0.7856 GB, free: 3.984 MB / 0.7448 GB
Notification: Performance of NFFlatten.flatten: time 0.006574/0.03648, allocations: 2.571 MB / 0.7881 GB, free: 1.41 MB / 0.7448 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003311/0.03979, allocations: 0.8152 MB / 0.7889 GB, free: 0.5273 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004479/0.04427, allocations: 1.239 MB / 0.7902 GB, free: 15.29 MB / 0.7605 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001727/0.046, allocations: 0.5527 MB / 0.7907 GB, free: 14.73 MB / 0.7605 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007446/0.04674, allocations: 216 kB / 0.7909 GB, free: 14.52 MB / 0.7605 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.000445/0.04719, allocations: 224 kB / 0.7911 GB, free: 14.3 MB / 0.7605 GB
Notification: Performance of combineBinaries: time 0.003545/0.05073, allocations: 2.847 MB / 0.7939 GB, free: 11.43 MB / 0.7605 GB
Notification: Performance of replaceArrayConstructors: time 0.002162/0.05289, allocations: 1.743 MB / 0.7956 GB, free: 9.676 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004355/0.05333, allocations: 108 kB / 0.7957 GB, free: 9.57 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 0.0005992/0.05393, allocations: 130.8 kB / 0.7958 GB, free: 9.441 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 405 (405)
 * Number of variables: 405 (405)
Notification: Performance of [SIM] Bindings: time 0.01149/0.06542, allocations: 7.843 MB / 0.8035 GB, free: 1.281 MB / 0.7605 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001457/0.06688, allocations: 0.9953 MB / 0.8045 GB, free: 292 kB / 0.7605 GB
Notification: Performance of [SIM] Early Inline: time 0.605/0.6718, allocations: 5.139 MB / 0.8095 GB, free: 29.05 MB / 0.7605 GB
Notification: Performance of [SIM] Simplify 1: time 0.001267/0.6731, allocations: 0.4907 MB / 0.81 GB, free: 28.82 MB / 0.7605 GB
Notification: Performance of [SIM] Alias: time 0.01751/0.6906, allocations: 9.783 MB / 0.8195 GB, free: 24.27 MB / 0.7605 GB
Notification: Performance of [SIM] Simplify 2: time 0.000587/0.6912, allocations: 254.7 kB / 0.8198 GB, free: 24.15 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Stream: time 0.0003479/0.6916, allocations: 270.9 kB / 0.82 GB, free: 23.95 MB / 0.7605 GB
Notification: Performance of [SIM] Detect States: time 0.001288/0.6928, allocations: 0.8885 MB / 0.8209 GB, free: 23.37 MB / 0.7605 GB
Notification: Performance of [SIM] Events: time 0.0007131/0.6936, allocations: 431 kB / 0.8213 GB, free: 23.2 MB / 0.7605 GB
Notification: Performance of [SIM] Partitioning: time 0.001881/0.6954, allocations: 1.092 MB / 0.8224 GB, free: 22.59 MB / 0.7605 GB
Notification: Performance of [SIM] Causalize: time 0.002925/0.6984, allocations: 1.399 MB / 0.8237 GB, free: 22.24 MB / 0.7605 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002653/0.701, allocations: 2.237 MB / 0.8259 GB, free: 20.81 MB / 0.7605 GB
Notification: Performance of [INI] Simplify: time 0.004873/0.7059, allocations: 2.554 MB / 0.8284 GB, free: 19.54 MB / 0.7605 GB
Notification: Performance of [INI] Inline: time 0.00356/0.7094, allocations: 3.055 MB / 0.8314 GB, free: 17.57 MB / 0.7605 GB
Notification: Performance of [INI] Partitioning: time 0.0001465/0.7096, allocations: 69.81 kB / 0.8314 GB, free: 17.51 MB / 0.7605 GB
Notification: Performance of [INI] Cleanup: time 0.0008096/0.7104, allocations: 0.8894 MB / 0.8323 GB, free: 16.91 MB / 0.7605 GB
Notification: Performance of [INI] Causalize: time 0.00616/0.7166, allocations: 3.242 MB / 0.8355 GB, free: 15.99 MB / 0.7605 GB
Notification: Performance of [INI] Tearing: time 9.886e-05/0.7167, allocations: 142.2 kB / 0.8356 GB, free: 15.89 MB / 0.7605 GB
Notification: Performance of [SIM] Initialization: time 3.787e-06/0.7167, allocations: 1.219 kB / 0.8356 GB, free: 15.89 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Dummies: time 2.804e-05/0.7167, allocations: 4.469 kB / 0.8356 GB, free: 15.89 MB / 0.7605 GB
Notification: Performance of [SIM] Tearing: time 5.034e-05/0.7167, allocations: 64.53 kB / 0.8357 GB, free: 15.84 MB / 0.7605 GB
Notification: Performance of [SIM] Categorize: time 2.741e-05/0.7168, allocations: 6.125 kB / 0.8357 GB, free: 15.84 MB / 0.7605 GB
Notification: Performance of [SIM] Solve: time 0.001945/0.7187, allocations: 1.065 MB / 0.8367 GB, free: 15.43 MB / 0.7605 GB
Notification: Performance of [SIM] Jacobian: time 0.001508/0.7202, allocations: 0.7673 MB / 0.8375 GB, free: 15.15 MB / 0.7605 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 7.063e-06/0.7202, allocations: 4.641 kB / 0.8375 GB, free: 15.15 MB / 0.7605 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: ......... 1
 * 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: ............................. 3 (3) {disMinCon.maxRetDam.addPID.u2, disMinCon1.maxRetDam.addPID.u2, minCon.maxRetDam.addPID.u2}
 * Number of discrete states: .................... 3 (3) {minCon.maxRetDam.trigger, disMinCon1.maxRetDam.trigger, disMinCon.maxRetDam.trigger}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 44 (44) {disMinCon.y1MinOutDam, disMinCon.greThr.greHys.y, disMinCon.les.lesHys.y, disMinCon.gre.greHys.y, disMinCon.enaRetDamMin.u2, disMinCon.enaRetDamMin.y, disMinCon.disRetDamMin.u2, disMinCon.disRetDamMin.y, disMinCon.intEqu.y, disMinCon.enaMinDam1.y, disMinCon.enaMinDam2.u1, disMinCon1.y1MinOutDam, disMinCon1.greThr.greHys.y, disMinCon1.les.lesHys.y, disMinCon1.gre.greHys.y, disMinCon1.enaRetDamMin.u2, disMinCon1.enaRetDamMin.y, disMinCon1.disRetDamMin.u2, disMinCon1.disRetDamMin.y, disMinCon1.intEqu.y, disMinCon1.enaMinDam1.y, disMinCon1.enaMinDam2.u1, minCon.y1MinOutDam, minCon.greThr.greHys.y, minCon.les.lesHys.y, minCon.gre.greHys.y, minCon.enaRetDamMin.u2, minCon.enaRetDamMin.y, minCon.disRetDamMin.u2, minCon.disRetDamMin.y, minCon.intEqu.y, minCon.enaMinDam1.y, minCon.enaMinDam2.u1, $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: ........... 117 (scalar:117, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:0, when:3, 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: ........... 135 (scalar:135, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 135 (scalar:135, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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.000117/0.7203, allocations: 98.12 kB / 0.8376 GB, free: 15.07 MB / 0.7605 GB
Notification: Performance of SimCode: time 0.005224/0.7256, allocations: 2.903 MB / 0.8404 GB, free: 13.42 MB / 0.7605 GB
Notification: Performance of Templates: time 0.02103/0.7466, allocations: 9.982 MB / 0.8502 GB, free: 6.93 MB / 0.7605 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe >> ../files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.sim & ./Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 9.06280604749918]