Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.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.00213/0.00213, allocations: 80.88 kB / 21.56 MB, free: 2.93 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.00265/0.00265, allocations: 169.6 kB / 24.97 MB, free: 9.195 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.837/1.837, allocations: 177.1 MB / 205.4 MB, free: 5.102 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.391/3.391, allocations: 389.5 MB / 0.6361 GB, free: 12.32 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.SetPoints.Validation.SupplyFan,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.525e-05/2.525e-05, allocations: 2.312 kB / 0.776 GB, free: 5.301 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan): time 0.01199/0.01202, allocations: 6.899 MB / 0.7827 GB, free: 14.43 MB / 0.7449 GB
Notification: Performance of NFInst.instExpressions: time 0.01288/0.0249, allocations: 4.563 MB / 0.7872 GB, free: 9.836 MB / 0.7449 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003185/0.02808, allocations: 80.66 kB / 0.7873 GB, free: 9.758 MB / 0.7449 GB
Notification: Performance of NFTyping.typeComponents: time 0.001349/0.02943, allocations: 415.1 kB / 0.7877 GB, free: 9.348 MB / 0.7449 GB
Notification: Performance of NFTyping.typeBindings: time 0.001998/0.03143, allocations: 453.2 kB / 0.7881 GB, free: 8.906 MB / 0.7449 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002976/0.0344, allocations: 1.278 MB / 0.7893 GB, free: 7.629 MB / 0.7449 GB
Notification: Performance of NFFlatten.flatten: time 0.005971/0.04038, allocations: 3.88 MB / 0.7931 GB, free: 3.781 MB / 0.7449 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002813/0.04319, allocations: 1.253 MB / 0.7944 GB, free: 2.449 MB / 0.7449 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003465/0.04665, allocations: 1.946 MB / 0.7963 GB, free: 0.5 MB / 0.7449 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001326/0.04798, allocations: 0.922 MB / 0.7972 GB, free: 15.58 MB / 0.7605 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007521/0.04873, allocations: 412 kB / 0.7976 GB, free: 15.18 MB / 0.7605 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006705/0.0494, allocations: 432 kB / 0.798 GB, free: 14.75 MB / 0.7605 GB
Notification: Performance of combineBinaries: time 0.004889/0.05429, allocations: 4.595 MB / 0.8025 GB, free: 10.13 MB / 0.7605 GB
Notification: Performance of replaceArrayConstructors: time 0.003051/0.05734, allocations: 2.688 MB / 0.8051 GB, free: 7.418 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008225/0.05817, allocations: 176 kB / 0.8052 GB, free: 7.246 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 0.0009092/0.05908, allocations: 209.8 kB / 0.8054 GB, free: 7.039 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: 665 (665)
 * Number of variables: 665 (665)
Notification: Performance of [SIM] Bindings: time 0.01651/0.07558, allocations: 12.91 MB / 0.8181 GB, free: 9.77 MB / 0.7761 GB
Notification: Performance of [SIM] FunctionAlias: time 0.003705/0.07929, allocations: 2.392 MB / 0.8204 GB, free: 7.348 MB / 0.7761 GB
Notification: Performance of [SIM] Early Inline: time 0.01747/0.09675, allocations: 12.45 MB / 0.8325 GB, free: 10.77 MB / 0.7917 GB
Notification: Performance of [SIM] Simplify 1: time 0.002009/0.09876, allocations: 0.8624 MB / 0.8334 GB, free: 9.793 MB / 0.7917 GB
Notification: Performance of [SIM] Alias: time 0.02755/0.1263, allocations: 16.25 MB / 0.8493 GB, free: 7.641 MB / 0.8074 GB
Notification: Performance of [SIM] Simplify 2: time 0.0009542/0.1273, allocations: 469.9 kB / 0.8497 GB, free: 7.133 MB / 0.8074 GB
Notification: Performance of [SIM] Remove Stream: time 0.0006884/0.128, allocations: 0.5254 MB / 0.8502 GB, free: 6.555 MB / 0.8074 GB
Notification: Performance of [SIM] Detect States: time 0.002608/0.1306, allocations: 1.881 MB / 0.8521 GB, free: 4.59 MB / 0.8074 GB
Notification: Performance of [SIM] Events: time 0.001297/0.1319, allocations: 0.8725 MB / 0.8529 GB, free: 3.684 MB / 0.8074 GB
Notification: Performance of [SIM] Partitioning: time 0.00351/0.1354, allocations: 2.271 MB / 0.8551 GB, free: 1.227 MB / 0.8074 GB
Notification: Performance of [SIM] Causalize: time 0.004903/0.1403, allocations: 2.909 MB / 0.858 GB, free: 14.22 MB / 0.823 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.006025/0.1463, allocations: 4.801 MB / 0.8626 GB, free: 9.418 MB / 0.823 GB
Notification: Performance of [INI] Simplify: time 0.008754/0.1551, allocations: 5.124 MB / 0.8677 GB, free: 4.113 MB / 0.823 GB
Notification: Performance of [INI] Inline: time 0.01017/0.1652, allocations: 8.362 MB / 0.8758 GB, free: 11.72 MB / 0.8386 GB
Notification: Performance of [INI] Partitioning: time 0.0003642/0.1656, allocations: 118.3 kB / 0.8759 GB, free: 11.57 MB / 0.8386 GB
Notification: Performance of [INI] Cleanup: time 0.002211/0.1678, allocations: 1.996 MB / 0.8779 GB, free: 9.551 MB / 0.8386 GB
Notification: Performance of [INI] Causalize: time 0.02062/0.1884, allocations: 11.86 MB / 0.8895 GB, free: 13.14 MB / 0.8542 GB
Notification: Performance of [INI] Tearing: time 0.0002831/0.1887, allocations: 316 kB / 0.8898 GB, free: 12.83 MB / 0.8542 GB
Notification: Performance of [SIM] Initialization: time 1.332e-06/0.1887, allocations: 0 / 0.8898 GB, free: 12.83 MB / 0.8542 GB
Notification: Performance of [SIM] Remove Dummies: time 5.156e-05/0.1887, allocations: 2 kB / 0.8898 GB, free: 12.83 MB / 0.8542 GB
Notification: Performance of [SIM] Tearing: time 0.0001104/0.1889, allocations: 128 kB / 0.8899 GB, free: 12.71 MB / 0.8542 GB
Notification: Performance of [SIM] Categorize: time 3.362e-05/0.1889, allocations: 19.92 kB / 0.8899 GB, free: 12.69 MB / 0.8542 GB
Notification: Performance of [SIM] Solve: time 0.00388/0.1928, allocations: 2.062 MB / 0.8919 GB, free: 10.59 MB / 0.8542 GB
Notification: Performance of [SIM] Jacobian: time 0.002609/0.1954, allocations: 1.333 MB / 0.8932 GB, free: 9.184 MB / 0.8542 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 7.975e-06/0.1954, allocations: 0 / 0.8932 GB, free: 9.184 MB / 0.8542 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: ......... 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) {conSupFan.conSpe.addPID.u2, conSupFan1.conSpe.addPID.u2, conSupFan2.conSpe.addPID.u2}
 * Number of discrete states: .................... 36 (36) {conSupFan2.firOrdHol.c, conSupFan2.firOrdHol.pre_uSample, conSupFan2.firOrdHol.uSample, conSupFan2.firOrdHol.tSample, conSupFan2.firOrdHol.firstTrigger, conSupFan2.staPreSetRes.lat.y, conSupFan2.staPreSetRes.sampler.y, conSupFan2.staPreSetRes.sampler.firstTrigger, conSupFan2.staPreSetRes.uniDel.y, conSupFan2.staPreSetRes.uniDel.u_internal, conSupFan2.staPreSetRes.swi.u2, conSupFan2.staPreSetRes.tim.t_next, conSupFan1.firOrdHol.c, conSupFan1.firOrdHol.pre_uSample, conSupFan1.firOrdHol.uSample, conSupFan1.firOrdHol.tSample, conSupFan1.firOrdHol.firstTrigger, conSupFan1.staPreSetRes.lat.y, conSupFan1.staPreSetRes.sampler.y, conSupFan1.staPreSetRes.sampler.firstTrigger, conSupFan1.staPreSetRes.uniDel.y, conSupFan1.staPreSetRes.uniDel.u_internal, conSupFan1.staPreSetRes.swi.u2, conSupFan1.staPreSetRes.tim.t_next, conSupFan.firOrdHol.c, conSupFan.firOrdHol.pre_uSample, conSupFan.firOrdHol.uSample, conSupFan.firOrdHol.tSample, conSupFan.firOrdHol.firstTrigger, conSupFan.staPreSetRes.lat.y, conSupFan.staPreSetRes.sampler.y, conSupFan.staPreSetRes.sampler.firstTrigger, conSupFan.staPreSetRes.uniDel.y, conSupFan.staPreSetRes.uniDel.u_internal, conSupFan.staPreSetRes.swi.u2, conSupFan.staPreSetRes.tim.t_next}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 102 (102) {conSupFan.uOpeMod, conSupFan.uZonPreResReq, conSupFan.y1SupFan, conSupFan.staPreSetRes.tim.u, conSupFan.staPreSetRes.uniDel.sampleTrigger, conSupFan.staPreSetRes.swi3.u2, conSupFan.staPreSetRes.sampler.sampleTrigger, conSupFan.staPreSetRes.and2.u2, conSupFan.staPreSetRes.and2.y, conSupFan.staPreSetRes.assMes.u, conSupFan.staPreSetRes.assMes2.u, conSupFan.staPreSetRes.lat.u, conSupFan.staPreSetRes.notHolAndTic.y, conSupFan.or3.y, conSupFan.intEqu.y, conSupFan.intEqu1.y, conSupFan.intEqu2.y, conSupFan.intEqu3.y, conSupFan.intEqu4.y, conSupFan.firOrdHol.sampleTrigger, conSupFan.or4.y, conSupFan1.y1SupFan, conSupFan1.staPreSetRes.tim.u, conSupFan1.staPreSetRes.uniDel.sampleTrigger, conSupFan1.staPreSetRes.swi3.u2, conSupFan1.staPreSetRes.sampler.sampleTrigger, conSupFan1.staPreSetRes.and2.u2, conSupFan1.staPreSetRes.and2.y, conSupFan1.staPreSetRes.assMes.u, conSupFan1.staPreSetRes.assMes2.u, conSupFan1.staPreSetRes.lat.u, conSupFan1.staPreSetRes.notHolAndTic.y, conSupFan1.or2.y, conSupFan1.or3.y, conSupFan1.intEqu.y, conSupFan1.intEqu1.y, conSupFan1.intEqu2.y, conSupFan1.intEqu3.y, conSupFan1.intEqu4.y, conSupFan1.firOrdHol.sampleTrigger, conSupFan1.or4.y, conSupFan2.y1SupFan, conSupFan2.staPreSetRes.tim.u, conSupFan2.staPreSetRes.uniDel.sampleTrigger, conSupFan2.staPreSetRes.swi3.u2, conSupFan2.staPreSetRes.sampler.sampleTrigger, conSupFan2.staPreSetRes.and2.u2, conSupFan2.staPreSetRes.and2.y, conSupFan2.staPreSetRes.assMes.u, conSupFan2.staPreSetRes.assMes2.u, conSupFan2.staPreSetRes.lat.u, conSupFan2.staPreSetRes.notHolAndTic.y, conSupFan2.or3.y, conSupFan2.intEqu.y, conSupFan2.intEqu1.y, conSupFan2.intEqu2.y, conSupFan2.intEqu3.y, conSupFan2.intEqu4.y, conSupFan2.firOrdHol.sampleTrigger, conSupFan2.or4.y, $WC_5, $WC_4, $WC_3, $WC_2, $WC_1, $WC_0, $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_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 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: ........... 212 (scalar:212, array:0, record:0)
 * Number of multi strong components: ............ 36 (algorithm:0, when:36, 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: ........... 309 (scalar:309, array:0, record:0)
 * Number of multi strong components: ............ 9 (algorithm:9, 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: ........... 309 (scalar:309, array:0, record:0)
 * Number of multi strong components: ............ 9 (algorithm:9, 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.0002668/0.1957, allocations: 215.7 kB / 0.8934 GB, free: 8.965 MB / 0.8542 GB
Notification: Performance of SimCode: time 0.009653/0.2053, allocations: 4.819 MB / 0.8981 GB, free: 3.922 MB / 0.8542 GB
Notification: Performance of Templates: time 0.04007/0.2454, allocations: 19.32 MB / 0.917 GB, free: 0.8828 MB / 0.8699 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.pipe >> ../files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.sim & ./Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.SupplyFan.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 9.578210227191448]