Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.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.002014/0.002014, 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.002337/0.002337, allocations: 165.8 kB / 24.97 MB, free: 9.125 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.626/1.626, allocations: 177.1 MB / 205.4 MB, free: 5.477 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.404/3.404, 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.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage")
translateModel(Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.761e-05/2.761e-05, allocations: 2.312 kB / 0.7759 GB, free: 5.426 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage): time 0.005446/0.005473, allocations: 2.475 MB / 0.7783 GB, free: 2.969 MB / 0.7292 GB
Notification: Performance of NFInst.instExpressions: time 0.003478/0.008952, allocations: 1.448 MB / 0.7797 GB, free: 1.523 MB / 0.7292 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003749/0.009327, allocations: 7.938 kB / 0.7797 GB, free: 1.516 MB / 0.7292 GB
Notification: Performance of NFTyping.typeComponents: time 0.0005018/0.009829, allocations: 121.1 kB / 0.7799 GB, free: 1.398 MB / 0.7292 GB
Notification: Performance of NFTyping.typeBindings: time 0.0005625/0.01039, allocations: 160.8 kB / 0.78 GB, free: 1.242 MB / 0.7292 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001012/0.0114, allocations: 359 kB / 0.7803 GB, free: 0.8945 MB / 0.7292 GB
Notification: Performance of NFFlatten.flatten: time 0.001308/0.01271, allocations: 0.8407 MB / 0.7812 GB, free: 60 kB / 0.7292 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008881/0.0136, allocations: 435.6 kB / 0.7816 GB, free: 15.63 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008891/0.01449, allocations: 484.2 kB / 0.782 GB, free: 15.16 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004125/0.0149, allocations: 227.3 kB / 0.7823 GB, free: 14.94 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001205/0.01502, allocations: 69 kB / 0.7823 GB, free: 14.87 MB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003017/0.01532, allocations: 115.8 kB / 0.7824 GB, free: 14.76 MB / 0.7448 GB
Notification: Performance of combineBinaries: time 0.0009247/0.01625, allocations: 0.8269 MB / 0.7832 GB, free: 13.93 MB / 0.7448 GB
Notification: Performance of replaceArrayConstructors: time 0.0004275/0.01668, allocations: 456.7 kB / 0.7837 GB, free: 13.48 MB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 6.953e-05/0.01674, allocations: 32.53 kB / 0.7837 GB, free: 13.45 MB / 0.7448 GB
Notification: Performance of FrontEnd: time 0.0001631/0.01691, allocations: 67.55 kB / 0.7838 GB, free: 13.38 MB / 0.7448 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 117 (113)
 * Number of variables: 117 (111)
Notification: Performance of [SIM] Bindings: time 0.003862/0.02077, allocations: 2.361 MB / 0.7861 GB, free: 10.89 MB / 0.7448 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0008355/0.02161, allocations: 450.4 kB / 0.7865 GB, free: 10.45 MB / 0.7448 GB
Notification: Performance of [SIM] Early Inline: time 0.003348/0.02495, allocations: 2.519 MB / 0.789 GB, free: 7.895 MB / 0.7448 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004486/0.0254, allocations: 217.7 kB / 0.7892 GB, free: 7.652 MB / 0.7448 GB
Notification: Performance of [SIM] Alias: time 0.004647/0.03005, allocations: 2.444 MB / 0.7916 GB, free: 4.996 MB / 0.7448 GB
Notification: Performance of [SIM] Simplify 2: time 0.0005712/0.03062, allocations: 251 kB / 0.7918 GB, free: 4.699 MB / 0.7448 GB
Notification: Performance of [SIM] Remove Stream: time 0.0003276/0.03095, allocations: 191.2 kB / 0.792 GB, free: 4.484 MB / 0.7448 GB
Notification: Performance of [SIM] Detect States: time 0.001077/0.03202, allocations: 0.6418 MB / 0.7926 GB, free: 3.785 MB / 0.7448 GB
Notification: Performance of [SIM] Events: time 0.000516/0.03254, allocations: 287 kB / 0.7929 GB, free: 3.52 MB / 0.7448 GB
Notification: Performance of [SIM] Partitioning: time 0.001331/0.03387, allocations: 0.7388 MB / 0.7936 GB, free: 2.746 MB / 0.7448 GB
Notification: Performance of [SIM] Causalize: time 0.002019/0.03589, allocations: 1.098 MB / 0.7947 GB, free: 1.676 MB / 0.7448 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001889/0.03778, allocations: 1.495 MB / 0.7961 GB, free: 184 kB / 0.7448 GB
Notification: Performance of [INI] Simplify: time 0.004425/0.0422, allocations: 0.9008 MB / 0.797 GB, free: 15.27 MB / 0.7605 GB
Notification: Performance of [INI] Inline: time 0.003444/0.04565, allocations: 2.593 MB / 0.7996 GB, free: 12.67 MB / 0.7605 GB
Notification: Performance of [INI] Partitioning: time 0.0001462/0.04579, allocations: 47.38 kB / 0.7996 GB, free: 12.62 MB / 0.7605 GB
Notification: Performance of [INI] Cleanup: time 0.0004951/0.04629, allocations: 367.7 kB / 0.8 GB, free: 12.26 MB / 0.7605 GB
Notification: Performance of [INI] Causalize: time 0.005209/0.0515, allocations: 2.342 MB / 0.8022 GB, free: 9.934 MB / 0.7605 GB
Notification: Performance of [INI] Tearing: time 7.443e-05/0.05157, allocations: 52 kB / 0.8023 GB, free: 9.883 MB / 0.7605 GB
Notification: Performance of [SIM] Initialization: time 2.434e-06/0.05157, allocations: 0 / 0.8023 GB, free: 9.883 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Dummies: time 2.521e-05/0.0516, allocations: 0.6562 kB / 0.8023 GB, free: 9.883 MB / 0.7605 GB
Notification: Performance of [SIM] Tearing: time 3.967e-05/0.05164, allocations: 40 kB / 0.8023 GB, free: 9.844 MB / 0.7605 GB
Notification: Performance of [SIM] Categorize: time 2.978e-05/0.05167, allocations: 7.938 kB / 0.8023 GB, free: 9.836 MB / 0.7605 GB
Notification: Performance of [SIM] Solve: time 0.001591/0.05326, allocations: 0.6689 MB / 0.803 GB, free: 9.16 MB / 0.7605 GB
Notification: Performance of [SIM] Jacobian: time 1.91e-05/0.05328, allocations: 4.156 kB / 0.803 GB, free: 9.156 MB / 0.7605 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 5.21e-07/0.05328, allocations: 0 / 0.803 GB, free: 9.156 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: ............... 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: .................... 6 (6) {speSig.T_start, speSig.count, varSpePumSta.con4.t_start, varSpePumSta.con3.t_start, varSpePumSta.con2.t_start, varSpePumSta.con1.t_start}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 68 (64) {varSpePumSta.con1.localCondition, varSpePumSta.con1.enableFire, varSpePumSta.con1.fire, varSpePumSta.con1.inPort.available, varSpePumSta.con1.outPort.occupied, varSpePumSta.oneOn.localActive, varSpePumSta.oneOn.inPort.occupied, varSpePumSta.oneOn.inPort.set, varSpePumSta.oneOn.outPort.available, varSpePumSta.oneOn.outPort.reset, varSpePumSta.oneOn.newActive, varSpePumSta.off.active, varSpePumSta.off.localActive, varSpePumSta.off.inPort.occupied, varSpePumSta.off.inPort.set, varSpePumSta.off.outPort.available, varSpePumSta.off.outPort.reset, varSpePumSta.off.newActive, varSpePumSta.twoOn.localActive, varSpePumSta.twoOn.inPort.occupied, varSpePumSta.twoOn.inPort.set, varSpePumSta.twoOn.outPort.available, varSpePumSta.twoOn.outPort.reset, varSpePumSta.twoOn.newActive, varSpePumSta.con2.localCondition, varSpePumSta.con2.enableFire, varSpePumSta.con2.fire, varSpePumSta.con2.inPort.available, varSpePumSta.con2.outPort.occupied, varSpePumSta.con3.localCondition, varSpePumSta.con3.enableFire, varSpePumSta.con3.fire, varSpePumSta.con3.inPort.available, varSpePumSta.con3.outPort.occupied, varSpePumSta.con4.localCondition, varSpePumSta.con4.enableFire, varSpePumSta.con4.fire, varSpePumSta.con4.inPort.available, varSpePumSta.con4.outPort.occupied, varSpePumSta.stateGraphRoot.activeSteps, varSpePumSta.booToInt.y, varSpePumSta.booToInt1.y, varSpePumSta.addInt.y, $FUN_1, $FUN_2, $FUN_3, $FUN_4, $FUN_5, $FUN_6, $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_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: ........... 70 (scalar:70, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:0, when:4, if:0, tuple:0)
 * Number of for-loop strong components: ......... 3 (resizable: 1, generic: 0, entwined:2)
 * 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: ........... 94 (scalar:94, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 3 (resizable: 1, generic: 0, entwined:2)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001396/0.05342, allocations: 85.84 kB / 0.8031 GB, free: 9.074 MB / 0.7605 GB
Notification: Performance of SimCode: time 0.006722/0.06014, allocations: 1.694 MB / 0.8047 GB, free: 7.555 MB / 0.7605 GB
Notification: Performance of Templates: time 0.01799/0.07813, allocations: 6.475 MB / 0.8111 GB, free: 1.152 MB / 0.7605 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.pipe ; mkfifo Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.pipe ; head -c 1048576 < Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.pipe >> ../files/Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.sim & ./Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Applications.BaseClasses.Controls.Validation.VariableSpeedPumpStage.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 9.148611105978489]