Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.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="mat",numberOfIntervals=5000,variableFilter="time|disMinCon.VOutMinSet_flow_normalized|disMinCon.u1SupFan|disMinCon.uOpeMod|disMinCon.yOutDam_min|disMinCon.yOutDam_max|disMinCon.yRetDam_min|disMinCon.yRetDam_max|disMinCon.minDp.y|disMinCon.dpMinOutDam|disMinCon.y1MinOutDam|disMinCon1.VOutMinSet_flow_normalized|disMinCon1.u1SupFan|disMinCon1.uOpeMod|disMinCon1.yOutDam_min|disMinCon1.yOutDam_max|disMinCon1.yRetDam_min|disMinCon1.yRetDam_max|disMinCon1.minDp.y|disMinCon1.dpMinOutDam|disMinCon1.y1MinOutDam|minCon.VOutMinSet_flow_normalized|minCon.u1SupFan|minCon.uOpeMod|minCon.yOutDam_min|minCon.yOutDam_max|minCon.yRetDam_min|minCon.yRetDam_max|minCon.minDp.y|minCon.dpMinOutDam|minCon.y1MinOutDam",fileNamePrefix="Buildings_latest_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="mat",numberOfIntervals=5000,variableFilter="time|disMinCon.VOutMinSet_flow_normalized|disMinCon.u1SupFan|disMinCon.uOpeMod|disMinCon.yOutDam_min|disMinCon.yOutDam_max|disMinCon.yRetDam_min|disMinCon.yRetDam_max|disMinCon.minDp.y|disMinCon.dpMinOutDam|disMinCon.y1MinOutDam|disMinCon1.VOutMinSet_flow_normalized|disMinCon1.u1SupFan|disMinCon1.uOpeMod|disMinCon1.yOutDam_min|disMinCon1.yOutDam_max|disMinCon1.yRetDam_min|disMinCon1.yRetDam_max|disMinCon1.minDp.y|disMinCon1.dpMinOutDam|disMinCon1.y1MinOutDam|minCon.VOutMinSet_flow_normalized|minCon.u1SupFan|minCon.uOpeMod|minCon.yOutDam_min|minCon.yOutDam_max|minCon.yRetDam_min|minCon.yRetDam_max|minCon.minDp.y|minCon.dpMinOutDam|minCon.y1MinOutDam",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001265/0.001265, allocations: 111 kB / 16.42 MB, free: 6.527 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001148/0.001148, allocations: 185.5 kB / 17.35 MB, free: 5.75 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.217/1.217, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.339/2.339, allocations: 472.6 MB / 0.7459 GB, free: 0.5391 MB / 0.6075 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.218e-05/2.214e-05, allocations: 2.281 kB / 1.07 GB, free: 9.555 MB / 0.8419 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP): time 0.006646/0.006682, allocations: 6.092 MB / 1.076 GB, free: 3.441 MB / 0.8419 GB
Notification: Performance of NFInst.instExpressions: time 0.004421/0.01113, allocations: 2.858 MB / 1.079 GB, free: 0.5625 MB / 0.8419 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008404/0.01199, allocations: 47.81 kB / 1.079 GB, free: 0.5156 MB / 0.8419 GB
Notification: Performance of NFTyping.typeComponents: time 0.0006527/0.01265, allocations: 324.5 kB / 1.079 GB, free: 200 kB / 0.8419 GB
Notification: Performance of NFTyping.typeBindings: time 0.4742/0.4869, allocations: 270.7 kB / 1.08 GB, free: 11.38 MB / 0.8419 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002106/0.4891, allocations: 0.7776 MB / 1.08 GB, free: 11.38 MB / 0.8419 GB
Notification: Performance of NFFlatten.flatten: time 0.003604/0.4927, allocations: 2.509 MB / 1.083 GB, free: 11.34 MB / 0.8419 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001678/0.4944, allocations: 1.274 MB / 1.084 GB, free: 10.81 MB / 0.8419 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009599/0.4953, allocations: 0.7541 MB / 1.085 GB, free: 10.36 MB / 0.8419 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007453/0.4961, allocations: 0.8227 MB / 1.086 GB, free: 9.871 MB / 0.8419 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003416/0.4964, allocations: 239.4 kB / 1.086 GB, free: 9.871 MB / 0.8419 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003446/0.4968, allocations: 240.4 kB / 1.086 GB, free: 9.871 MB / 0.8419 GB
Notification: Performance of combineBinaries: time 0.001819/0.4986, allocations: 2.89 MB / 1.089 GB, free: 7.766 MB / 0.8419 GB
Notification: Performance of replaceArrayConstructors: time 0.0009351/0.4996, allocations: 1.853 MB / 1.091 GB, free: 6.391 MB / 0.8419 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004344/0.5, allocations: 314.1 kB / 1.091 GB, free: 6.191 MB / 0.8419 GB
Notification: Performance of FrontEnd: time 0.0005517/0.5006, allocations: 129.6 kB / 1.091 GB, free: 6.145 MB / 0.8419 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 Bindings: time 0.007214/0.5078, allocations: 8.678 MB / 1.099 GB, free: 136 kB / 0.8419 GB
Notification: Performance of FunctionAlias: time 0.0007102/0.5085, allocations: 418.4 kB / 1.1 GB, free: 15.99 MB / 0.8575 GB
Notification: Performance of Early Inline: time 0.004935/0.5135, allocations: 4.489 MB / 1.104 GB, free: 13.03 MB / 0.8575 GB
Notification: Performance of simplify1: time 0.0005101/0.514, allocations: 308.6 kB / 1.105 GB, free: 12.88 MB / 0.8575 GB
Notification: Performance of Alias: time 0.01496/0.5289, allocations: 11.37 MB / 1.116 GB, free: 6.051 MB / 0.8575 GB
Notification: Performance of simplify2: time 0.0004511/0.5294, allocations: 158.4 kB / 1.116 GB, free: 5.992 MB / 0.8575 GB
Notification: Performance of Detect States: time 0.0009707/0.5304, allocations: 0.8835 MB / 1.117 GB, free: 5.391 MB / 0.8575 GB
Notification: Performance of Events: time 0.0009451/0.5314, allocations: 0.6925 MB / 1.117 GB, free: 4.988 MB / 0.8575 GB
Notification: Performance of Partitioning: time 0.001143/0.5325, allocations: 0.9941 MB / 1.118 GB, free: 4.391 MB / 0.8575 GB
Notification: Performance of Causalize: time 0.004212/0.5367, allocations: 3.615 MB / 1.122 GB, free: 3.031 MB / 0.8575 GB
Notification: Performance of After Index Reduction Inline: time 0.002687/0.5394, allocations: 2.611 MB / 1.124 GB, free: 1.391 MB / 0.8575 GB
Notification: Performance of Inline: time 0.007309/0.5468, allocations: 6.101 MB / 1.13 GB, free: 13.65 MB / 0.8731 GB
Notification: Performance of Partitioning: time 0.0005787/0.5474, allocations: 367.4 kB / 1.131 GB, free: 13.41 MB / 0.8731 GB
Notification: Performance of Cleanup: time 0.0009058/0.5483, allocations: 0.5815 MB / 1.131 GB, free: 13.04 MB / 0.8731 GB
Notification: Performance of Causalize: time 0.04172/0.59, allocations: 28.92 MB / 1.16 GB, free: 15.83 MB / 0.8887 GB
Notification: Performance of Tearing: time 7.202e-05/0.5901, allocations: 4 kB / 1.16 GB, free: 15.82 MB / 0.8887 GB
Notification: Performance of Initialization: time 1.743e-06/0.5901, allocations: 0 / 1.16 GB, free: 15.82 MB / 0.8887 GB
Notification: Performance of Tearing: time 3.087e-05/0.5902, allocations: 4 kB / 1.16 GB, free: 15.82 MB / 0.8887 GB
Notification: Performance of Categorize: time 4.317e-05/0.5902, allocations: 11.94 kB / 1.16 GB, free: 15.81 MB / 0.8887 GB
Notification: Performance of Solve: time 0.002415/0.5927, allocations: 0.9964 MB / 1.161 GB, free: 14.95 MB / 0.8887 GB
Notification: Performance of Jacobian: time 0.001459/0.5941, allocations: 1.584 MB / 1.162 GB, free: 13.31 MB / 0.8887 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 3
 * Number of algebraic event partitions: ......... 6
 * 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) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 83 (83) {disMinCon.enaRetDamMin.u1, disMinCon.enaRetDamMin.u2, disMinCon.enaRetDamMin.y, disMinCon.disRetDamMin.u2, disMinCon.disRetDamMin.y, disMinCon.intEqu.y, disMinCon.enaMinDam1.y, disMinCon.enaMinDam2.u1, disMinCon1.enaRetDamMin.u1, disMinCon1.enaRetDamMin.u2, disMinCon1.enaRetDamMin.y, disMinCon1.disRetDamMin.u2, disMinCon1.disRetDamMin.y, disMinCon1.intEqu.y, disMinCon1.enaMinDam1.y, disMinCon1.enaMinDam2.u1, minCon.enaRetDamMin.u1, minCon.enaRetDamMin.u2, minCon.enaRetDamMin.y, minCon.disRetDamMin.u2, minCon.disRetDamMin.y, minCon.intEqu.y, minCon.enaMinDam1.y, minCon.enaMinDam2.u1, $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, $TEV_22, $TEV_21, $TEV_20, $TEV_19, $TEV_18, $TEV_17, $TEV_16, $TEV_15, $TEV_14, $TEV_13, $TEV_12, $TEV_11, $TEV_10, $TEV_9, $TEV_8, $TEV_7, $TEV_6, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $TEV_1, $TEV_0}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 159 (scalar:159, 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 (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: ........... 367 (scalar:367, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:3, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 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: ........... 367 (scalar:367, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:3, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001562/0.5943, allocations: 156.1 kB / 1.162 GB, free: 13.16 MB / 0.8887 GB
Notification: Performance of SimCode: time 0.007857/0.6022, allocations: 8.089 MB / 1.17 GB, free: 7.309 MB / 0.8887 GB
Notification: Performance of Templates: time 0.02005/0.6222, allocations: 12.74 MB / 1.183 GB, free: 10.65 MB / 0.9044 GB
make -j1 -f Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.makefile
(rm -f Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe ; mkfifo Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe ; head -c 1048576 < Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe >> ../files/Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.sim & ./Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.Economizers.Subsequences.Limits.Validation.SeparateWithDP.pipe 2>&1)