Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Greenhouses_Greenhouses.Examples.Greenhouse_1.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.0013/0.0013, allocations: 99.64 kB / 18.95 MB, free: 2.668 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.001406/0.001406, allocations: 210.3 kB / 22.24 MB, free: 5.262 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.325/1.325, allocations: 230.6 MB / 256 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Greenhouses master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Greenhouses master/package.mo): time 0.07051/0.07051, allocations: 15.02 MB / 327.4 MB, free: 4.188 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package Greenhouses with version 1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Greenhouses master/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: "" <> buildModelFMU(Greenhouses.Examples.Greenhouse_1,fileNamePrefix="Greenhouses_Greenhouses_Examples_Greenhouse_1",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Greenhouses.Examples.Greenhouse_1,fileNamePrefix="Greenhouses_Greenhouses_Examples_Greenhouse_1",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Greenhouses requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001897/0.001897, allocations: 67.88 kB / 456.1 MB, free: 5.078 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1005/0.1024, allocations: 56.78 MB / 0.5009 GB, free: 12.19 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(Greenhouses.Examples.Greenhouse_1): time 0.2406/0.343, allocations: 40.88 MB / 0.5408 GB, free: 11.98 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.1881/0.5311, allocations: 151.9 MB / 0.6892 GB, free: 14.07 MB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005814/0.5369, allocations: 103.6 kB / 0.6893 GB, free: 13.97 MB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.004555/0.5415, allocations: 1.367 MB / 0.6906 GB, free: 12.59 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.008779/0.5503, allocations: 2.552 MB / 0.6931 GB, free: 10.02 MB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01064/0.5609, allocations: 4.301 MB / 0.6973 GB, free: 5.723 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.02072/0.5816, allocations: 17.53 MB / 0.7144 GB, free: 4.145 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.2881/0.8697, allocations: 7.344 MB / 0.7216 GB, free: 6.074 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01265/0.8824, allocations: 6.425 MB / 0.7279 GB, free: 6.074 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0138/0.8962, allocations: 7.295 MB / 0.735 GB, free: 5.25 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.006726/0.9029, allocations: 1.614 MB / 0.7366 GB, free: 5.25 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01016/0.913, allocations: 3.063 MB / 0.7396 GB, free: 5.25 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.007418/0.9205, allocations: 6.839 MB / 0.7463 GB, free: 4.289 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.01252/0.933, allocations: 8.112 MB / 0.7542 GB, free: 1.449 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.02989/0.9629, allocations: 28.09 MB / 0.7816 GB, free: 11.79 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 8.656e-06/0.9629, allocations: 5.75 kB / 0.7816 GB, free: 11.79 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 2.054e-06/0.9629, allocations: 0 / 0.7816 GB, free: 11.79 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.001261/0.9641, allocations: 1 kB / 0.7816 GB, free: 11.79 MB / 0.5606 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 7731
 * Number of variables: 7731
Notification: Performance of Generate backend data structure: time 0.06381/1.028, allocations: 27.41 MB / 0.8084 GB, free: 14.89 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 5.232e-05/1.028, allocations: 12.78 kB / 0.8084 GB, free: 14.88 MB / 0.5762 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.008926/1.037, allocations: 3.346 MB / 0.8117 GB, free: 12.79 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008358/1.045, allocations: 2.408 MB / 0.814 GB, free: 10.37 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01534/1.061, allocations: 6.293 MB / 0.8202 GB, free: 6.172 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007052/1.061, allocations: 0.7797 MB / 0.8209 GB, free: 5.727 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004794/1.066, allocations: 1.086 MB / 0.822 GB, free: 4.992 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.07077/1.137, allocations: 38.66 MB / 0.8597 GB, free: 15.07 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002473/1.137, allocations: 22.83 kB / 0.8598 GB, free: 15.06 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00258/1.14, allocations: 436.2 kB / 0.8602 GB, free: 14.64 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004159/1.14, allocations: 445.8 kB / 0.8606 GB, free: 14.2 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07373/1.214, allocations: 41.99 MB / 0.9016 GB, free: 4.336 MB / 0.6544 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.1157/1.33, allocations: 52.21 MB / 0.9526 GB, free: 0.5586 MB / 0.7012 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.2938/1.623, allocations: 37.24 MB / 0.9889 GB, free: 325.2 MB / 0.7325 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.04688/1.67, allocations: 31.57 MB / 1.02 GB, free: 315.6 MB / 0.7325 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05653/1.727, allocations: 24.27 MB / 1.043 GB, free: 305 MB / 0.7325 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0425/1.769, allocations: 33.47 MB / 1.076 GB, free: 284.2 MB / 0.7325 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007268/1.777, allocations: 2.683 MB / 1.079 GB, free: 281.5 MB / 0.7325 GB
Notification: Performance of pre-optimization done (n=6281): time 2.96e-05/1.777, allocations: 0 / 1.079 GB, free: 281.5 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=6281): time 1.751/3.528, allocations: 0.8869 GB / 1.966 GB, free: 415.2 MB / 1.014 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.002107/3.53, allocations: 4.465 MB / 1.97 GB, free: 411 MB / 1.014 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006083/3.536, allocations: 4.726 MB / 1.975 GB, free: 407.1 MB / 1.014 GB
Notification: Performance of collectPreVariables (initialization): time 0.003364/3.539, allocations: 286.8 kB / 1.975 GB, free: 406.9 MB / 1.014 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002374/3.541, allocations: 3.722 MB / 1.979 GB, free: 403.6 MB / 1.014 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0163/3.558, allocations: 22 MB / 2 GB, free: 383.9 MB / 1.014 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009038/3.567, allocations: 4.916 MB / 2.005 GB, free: 379.8 MB / 1.014 GB
Notification: Performance of setup shared object (initialization): time 4.575e-05/3.567, allocations: 308.4 kB / 2.005 GB, free: 379.5 MB / 1.014 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03318/3.6, allocations: 27.25 MB / 2.032 GB, free: 355.1 MB / 1.014 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03751/3.638, allocations: 32 MB / 2.063 GB, free: 323.7 MB / 1.014 GB
Notification: Performance of analyzeInitialSystem (initialization): time 5.044/8.682, allocations: 1.1 GB / 3.163 GB, free: 13.29 MB / 1.42 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.999e-05/8.682, allocations: 16 kB / 3.163 GB, free: 13.27 MB / 1.42 GB
Notification: Performance of matching and sorting (n=6769) (initialization): time 0.4365/9.119, allocations: 80.81 MB / 3.242 GB, free: 13.35 MB / 1.498 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00959/9.128, allocations: 7.086 MB / 3.249 GB, free: 6.23 MB / 1.498 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001923/9.128, allocations: 69.77 kB / 3.249 GB, free: 6.164 MB / 1.498 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00414/9.132, allocations: 1.019 MB / 3.25 GB, free: 5.133 MB / 1.498 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01981/9.152, allocations: 3.836 MB / 3.254 GB, free: 1.293 MB / 1.498 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02342/9.176, allocations: 17.39 MB / 3.271 GB, free: 14.99 MB / 1.529 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01915/9.195, allocations: 1.725 MB / 3.272 GB, free: 13.26 MB / 1.529 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007734/9.203, allocations: 1.926 MB / 3.274 GB, free: 11.34 MB / 1.529 GB
Warning: Assuming fixed start value for the following 24 variables:
         E_th_tot_kWhm2:VARIABLE(unit = \"kW.h/m2\" fixed = true )  type: Real
         W_el_illu:VARIABLE(unit = \"kW.h/m2\" fixed = true )  type: Real
         cover.T:VARIABLE(min = 0.0 start = cover.T_start unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         air.T:VARIABLE(min = 0.0 start = air.T_start unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         air.airVP.VP:VARIABLE(start = air.airVP.VP_start unit = \"Pa\" fixed = true )  type: Real
         canopy.T:VARIABLE(min = 0.0 start = canopy.T_start unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         floor.T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         Q_cd_Soil.Layer_c[1].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [1]
         Q_cd_Soil.Layer_s[1].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [5]
         Q_cd_Soil.Layer_s[2].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [5]
         Q_cd_Soil.Layer_s[3].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [5]
         Q_cd_Soil.Layer_s[4].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [5]
         Q_cd_Soil.Layer_s[5].T:VARIABLE(min = 0.0 start = 288.15 unit = \"K\" fixed = true nominal = 300.0 )  type: Real [5]
         thScreen.T:VARIABLE(min = 0.0 start = thScreen.T_start unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         air_Top.T:VARIABLE(min = 0.0 start = air_Top.T_start unit = \"K\" fixed = true nominal = 300.0 )  type: Real
         pipe_low.flow1DimInc.Cells[1].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_low.flow1DimInc.Cells[1].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         pipe_low.flow1DimInc.Cells[2].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_low.flow1DimInc.Cells[2].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         pipe_low.flow1DimInc.Cells[3].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_low.flow1DimInc.Cells[3].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         pipe_low.flow1DimInc.Cells[4].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_low.flow1DimInc.Cells[4].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         pipe_low.flow1DimInc.Cells[5].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_low.flow1DimInc.Cells[5].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         pipe_up.flow1DimInc.Cells[1].h:VARIABLE(min = -1e10 max = 1e10 start = pipe_up.flow1DimInc.Cells[1].hstart unit = \"J/kg\" fixed = true nominal = 1e6 stateSelect=StateSelect.always )  \"Fluid specific enthalpy at the cells\" type: Real [5]
         PID_Mdot.I:VARIABLE(start = PID_Mdot.CSstart / PID_Mdot.Kp fixed = true )  \"Integral action / Kp\" type: Real
         U_vents.PID.I:VARIABLE(start = U_vents.PID.CSstart / U_vents.PID.Kp fixed = true )  \"Integral action / Kp\" type: Real
         U_vents.PIDT.I:VARIABLE(start = U_vents.PIDT.CSstart / U_vents.PIDT.Kp fixed = true )  \"Integral action / Kp\" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 294
 * Number of states: 0 ()
 * Number of discrete variables: 174 ($PRE.SC.T2.enableFire,$PRE.SC.T3.enableFire,$PRE.SC.T4.enableFire,$PRE.SC.T6.enableFire,$PRE.SC.T7.enableFire,$PRE.SC.T1.enableFire,$PRE.SC.T5.enableFire,$PRE.SC.T2b.enableFire,$PRE.SC.T3b.enableFire,$PRE.SC.T8.enableFire,$PRE.SC.T9.enableFire,$PRE.SC.T8b.enableFire,$PRE.SC.T2c.enableFire,$PRE.SC.T3c.enableFire,SC.T3c.t_start,$PRE.SC.T3c.t_start,SC.T2c.t_start,$PRE.SC.T2c.t_start,SC.T8b.t_start,$PRE.SC.T8b.t_start,SC.T8.t_start,$PRE.SC.T8.t_start,SC.T3b.t_start,$PRE.SC.T3b.t_start,SC.T2b.t_start,$PRE.SC.T2b.t_start,SC.T5.t_start,$PRE.SC.T5.t_start,SC.T1.t_start,$PRE.SC.T1.t_start,SC.T7.t_start,$PRE.SC.T7.t_start,SC.T6.t_start,$PRE.SC.T6.t_start,SC.T3.t_start,$PRE.SC.T3.t_start,SC.T2.t_start,$PRE.SC.T2.t_start,SC.SC_crack2.entryTime,$PRE.SC.SC_crack2.entryTime,SC.SC_crack.entryTime,$PRE.SC.SC_crack.entryTime,$PRE.SP_new.nextTimeEvent,$whenCondition10,$PRE.SC_usable.nextTimeEvent,$whenCondition2,$PRE.TMY_and_control.nextTimeEvent,$whenCondition1,SC.stateGraphRoot.resume,SC.stateGraphRoot.suspend,SC.op,$PRE.SC.crack2.oldActive,$PRE.SC.crack2.newActive,$PRE.SC.crack2.localActive,$PRE.SC.T9.t_start,$PRE.SC.crack.oldActive,$PRE.SC.crack.newActive,$PRE.SC.crack.localActive,$PRE.SC.SC_CCD_value.entryTime,$PRE.SC.SC_OCD_value.entryTime,$PRE.SC.SC_OWD_value.entryTime,$PRE.SC.timer2.entryTime,$PRE.SC.closing_ColdDay.oldActive,$PRE.SC.closing_ColdDay.newActive,$PRE.SC.closing_ColdDay.localActive,$PRE.SC.timer1.entryTime,$PRE.SC.opening_WarmDay.oldActive,$PRE.SC.opening_WarmDay.newActive,$PRE.SC.opening_WarmDay.localActive,$PRE.SC.open.oldActive,$PRE.SC.open.newActive,$PRE.SC.open.localActive,$PRE.SC.timer.entryTime,$PRE.SC.opening_ColdDay.oldActive,$PRE.SC.opening_ColdDay.newActive,$PRE.SC.opening_ColdDay.localActive,$PRE.SC.T4.t_start,$PRE.SC.closed.oldActive,$PRE.SC.closed.newActive,$PRE.SC.closed.localActive,SP_new.nextTimeEventScaled,$PRE.SP_new.nextTimeEventScaled,SP_new.nextTimeEvent,SC.T3c.enableFire,SC.T3c.localCondition,SC.T2c.enableFire,SC.T2c.localCondition,SC.T8b.enableFire,SC.T8b.localCondition,SC.crack2.active,SC.crack2.oldActive,SC.crack2.newActive,SC.crack2.outPort[3].available,SC.crack2.outPort[2].available,SC.crack2.localActive,SC.T9.t_start,SC.T9.fire,SC.T9.enableFire,SC.T9.localCondition,SC.T8.enableFire,SC.T3b.enableFire,SC.T2b.enableFire,SC.crack.active,SC.crack.oldActive,SC.crack.newActive,SC.crack.outPort[4].available,SC.crack.outPort[3].available,SC.crack.outPort[2].available,SC.crack.localActive,SC.T5.enableFire,SC.T5.localCondition,SC.SC_CCD_value.entryTime,SC.SC_OCD_value.entryTime,SC.SC_OWD_value.entryTime,SC.T1.enableFire,SC.T1.localCondition,SC.timer2.entryTime,SC.closing_ColdDay.active,SC.closing_ColdDay.oldActive,SC.closing_ColdDay.newActive,SC.closing_ColdDay.localActive,SC.T7.enableFire,SC.T7.localCondition,SC.timer1.entryTime,SC.opening_WarmDay.active,SC.opening_WarmDay.oldActive,SC.opening_WarmDay.newActive,SC.opening_WarmDay.inPort[3].occupied,SC.opening_WarmDay.inPort[2].occupied,SC.opening_WarmDay.localActive,SC.open.oldActive,SC.open.newActive,SC.open.inPort[2].occupied,SC.open.localActive,SC.open.active,SC.T6.enableFire,SC.T6.localCondition,SC.timer.entryTime,SC.opening_ColdDay.active,SC.opening_ColdDay.oldActive,SC.opening_ColdDay.newActive,SC.opening_ColdDay.inPort[3].occupied,SC.opening_ColdDay.inPort[2].occupied,SC.opening_ColdDay.localActive,SC.T4.t_start,SC.T4.fire,SC.T4.enableFire,SC.T4.localCondition,SC.T3.enableFire,SC.T2.enableFire,SC.stateGraphRoot.activeSteps,SC.closed.oldActive,SC.closed.newActive,SC.closed.outPort[3].available,SC.closed.outPort[2].available,SC.closed.inPort[3].occupied,SC.closed.inPort[2].occupied,SC.closed.localActive,SC.closed.active,SC.cl,SC_usable.nextTimeEventScaled,$PRE.SC_usable.nextTimeEventScaled,SC_usable.nextTimeEvent,TMY_and_control.nextTimeEventScaled,$PRE.TMY_and_control.nextTimeEventScaled,TMY_and_control.nextTimeEvent,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,Q_cd_Soil.N_cc)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1708):
 * Single equations (assignments): 1693
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 5
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 4
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 4 systems
   {1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,4,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(4,40), (1,8)}
Notification: Performance of prepare postOptimizeDAE: time 0.03363/9.236, allocations: 14.93 MB / 3.289 GB, free: 12.42 MB / 1.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009639/9.246, allocations: 2.907 MB / 3.292 GB, free: 9.5 MB / 1.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 1.084/10.33, allocations: 0.5304 GB / 3.822 GB, free: 0.816 GB / 1.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.475e-05/10.33, allocations: 150.7 kB / 3.822 GB, free: 0.8158 GB / 1.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.482e-05/10.33, allocations: 4 kB / 3.822 GB, free: 0.8158 GB / 1.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0003674/10.33, allocations: 79.27 kB / 3.822 GB, free: 0.8158 GB / 1.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.7625/11.09, allocations: 0.5319 GB / 4.354 GB, free: 300 MB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.837e-05/11.09, allocations: 11.98 kB / 4.354 GB, free: 300 MB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01703/11.11, allocations: 3.239 MB / 4.358 GB, free: 296.8 MB / 1.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003305/11.11, allocations: 100.7 kB / 4.358 GB, free: 296.7 MB / 1.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006511/11.12, allocations: 1.066 MB / 4.359 GB, free: 295.6 MB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003531/11.12, allocations: 1.673 MB / 4.36 GB, free: 293.8 MB / 1.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.576e-06/11.12, allocations: 4 kB / 4.36 GB, free: 293.8 MB / 1.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 1.172/12.29, allocations: 0.5801 GB / 4.94 GB, free: 0.7633 GB / 1.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02074/12.31, allocations: 8.125 MB / 4.948 GB, free: 0.7562 GB / 1.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.007962/12.32, allocations: 0.94 MB / 4.949 GB, free: 0.7553 GB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01695/12.34, allocations: 1.625 MB / 4.951 GB, free: 0.754 GB / 1.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008908/12.35, allocations: 1.772 MB / 4.953 GB, free: 0.7526 GB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.006498/12.35, allocations: 1.781 MB / 4.954 GB, free: 0.7509 GB / 1.67 GB
Notification: Performance of sorting global known variables: time 0.004105/12.36, allocations: 2.981 MB / 4.957 GB, free: 0.748 GB / 1.67 GB
Notification: Performance of sort global known variables: time 7e-08/12.36, allocations: 0 / 4.957 GB, free: 0.748 GB / 1.67 GB
Notification: Performance of remove unused functions: time 0.02634/12.38, allocations: 9.294 MB / 4.966 GB, free: 0.739 GB / 1.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * Number of states: 140 (E_th_tot_kWhm2,W_el_illu,cover.T,air.T,air.airVP.VP,canopy.T,floor.T,Q_cd_Soil.Layer_c[1].T,Q_cd_Soil.Layer_s[1].T,Q_cd_Soil.Layer_s[2].T,Q_cd_Soil.Layer_s[3].T,Q_cd_Soil.Layer_s[4].T,Q_cd_Soil.Layer_s[5].T,thScreen.T,air_Top.T,air_Top.air.VP,pipe_low.flow1DimInc.Cells[1].h,pipe_low.flow1DimInc.Cells[2].h,pipe_low.flow1DimInc.Cells[3].h,pipe_low.flow1DimInc.Cells[4].h,pipe_low.flow1DimInc.Cells[5].h,pipe_up.flow1DimInc.Cells[1].h,pipe_up.flow1DimInc.Cells[2].h,pipe_up.flow1DimInc.Cells[3].h,pipe_up.flow1DimInc.Cells[4].h,pipe_up.flow1DimInc.Cells[5].h,PID_Mdot.I,TYM.C_Buf,TYM.T_can24C,TYM.T_canSumC,TYM.W_Fruit_1_Pot,TYM.C_Leaf,TYM.C_Stem,TYM.DM_Har,TYM.N_Fruit[1],TYM.N_Fruit[2],TYM.N_Fruit[3],TYM.N_Fruit[4],TYM.N_Fruit[5],TYM.N_Fruit[6],TYM.N_Fruit[7],TYM.N_Fruit[8],TYM.N_Fruit[9],TYM.N_Fruit[10],TYM.N_Fruit[11],TYM.N_Fruit[12],TYM.N_Fruit[13],TYM.N_Fruit[14],TYM.N_Fruit[15],TYM.N_Fruit[16],TYM.N_Fruit[17],TYM.N_Fruit[18],TYM.N_Fruit[19],TYM.N_Fruit[20],TYM.N_Fruit[21],TYM.N_Fruit[22],TYM.N_Fruit[23],TYM.N_Fruit[24],TYM.N_Fruit[25],TYM.N_Fruit[26],TYM.N_Fruit[27],TYM.N_Fruit[28],TYM.N_Fruit[29],TYM.N_Fruit[30],TYM.N_Fruit[31],TYM.N_Fruit[32],TYM.N_Fruit[33],TYM.N_Fruit[34],TYM.N_Fruit[35],TYM.N_Fruit[36],TYM.N_Fruit[37],TYM.N_Fruit[38],TYM.N_Fruit[39],TYM.N_Fruit[40],TYM.N_Fruit[41],TYM.N_Fruit[42],TYM.N_Fruit[43],TYM.N_Fruit[44],TYM.N_Fruit[45],TYM.N_Fruit[46],TYM.N_Fruit[47],TYM.N_Fruit[48],TYM.N_Fruit[49],TYM.N_Fruit[50],TYM.C_Fruit[1],TYM.C_Fruit[2],TYM.C_Fruit[3],TYM.C_Fruit[4],TYM.C_Fruit[5],TYM.C_Fruit[6],TYM.C_Fruit[7],TYM.C_Fruit[8],TYM.C_Fruit[9],TYM.C_Fruit[10],TYM.C_Fruit[11],TYM.C_Fruit[12],TYM.C_Fruit[13],TYM.C_Fruit[14],TYM.C_Fruit[15],TYM.C_Fruit[16],TYM.C_Fruit[17],TYM.C_Fruit[18],TYM.C_Fruit[19],TYM.C_Fruit[20],TYM.C_Fruit[21],TYM.C_Fruit[22],TYM.C_Fruit[23],TYM.C_Fruit[24],TYM.C_Fruit[25],TYM.C_Fruit[26],TYM.C_Fruit[27],TYM.C_Fruit[28],TYM.C_Fruit[29],TYM.C_Fruit[30],TYM.C_Fruit[31],TYM.C_Fruit[32],TYM.C_Fruit[33],TYM.C_Fruit[34],TYM.C_Fruit[35],TYM.C_Fruit[36],TYM.C_Fruit[37],TYM.C_Fruit[38],TYM.C_Fruit[39],TYM.C_Fruit[40],TYM.C_Fruit[41],TYM.C_Fruit[42],TYM.C_Fruit[43],TYM.C_Fruit[44],TYM.C_Fruit[45],TYM.C_Fruit[46],TYM.C_Fruit[47],TYM.C_Fruit[48],TYM.C_Fruit[49],TYM.C_Fruit[50],CO2_air.CO2,CO2_top.CO2,PID_CO2.I,U_vents.PID.I,U_vents.PIDT.I,U_vents.PIDT_noH.I)
 * Number of discrete variables: 107 (SC.T9.enableFire,SC.T4.enableFire,SC.crack2.localActive,SC.crack2.active,SC.crack.localActive,SC.crack.active,SC.closing_ColdDay.localActive,SC.closing_ColdDay.active,SC.opening_WarmDay.localActive,SC.opening_WarmDay.active,SC.open.localActive,SC.opening_ColdDay.localActive,SC.opening_ColdDay.active,SC.closed.localActive,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,TMY_and_control.nextTimeEvent,TMY_and_control.nextTimeEventScaled,SC_usable.nextTimeEvent,SC_usable.nextTimeEventScaled,SC.cl,SC.closed.active,SC.closed.inPort[2].occupied,SC.closed.inPort[3].occupied,SC.closed.outPort[2].available,SC.closed.outPort[3].available,SC.closed.newActive,SC.closed.oldActive,SC.stateGraphRoot.activeSteps,SC.T2.enableFire,SC.T3.enableFire,SC.T4.localCondition,SC.T4.fire,SC.T4.t_start,SC.opening_ColdDay.inPort[2].occupied,SC.opening_ColdDay.inPort[3].occupied,SC.opening_ColdDay.newActive,SC.opening_ColdDay.oldActive,SC.timer.entryTime,SC.T6.localCondition,SC.T6.enableFire,SC.open.active,SC.open.inPort[2].occupied,SC.open.newActive,SC.open.oldActive,SC.opening_WarmDay.inPort[2].occupied,SC.opening_WarmDay.inPort[3].occupied,SC.opening_WarmDay.newActive,SC.opening_WarmDay.oldActive,SC.timer1.entryTime,SC.T7.localCondition,SC.T7.enableFire,SC.closing_ColdDay.newActive,SC.closing_ColdDay.oldActive,SC.timer2.entryTime,SC.T1.localCondition,SC.T1.enableFire,SC.SC_OWD_value.entryTime,SC.SC_OCD_value.entryTime,SC.SC_CCD_value.entryTime,SC.T5.localCondition,SC.T5.enableFire,SC.crack.outPort[2].available,SC.crack.outPort[3].available,SC.crack.outPort[4].available,SC.crack.newActive,SC.crack.oldActive,SC.SC_crack.entryTime,SC.T2b.enableFire,SC.T3b.enableFire,SC.T8.enableFire,SC.T9.localCondition,SC.T9.fire,SC.T9.t_start,SC.SC_crack2.entryTime,SC.crack2.outPort[2].available,SC.crack2.outPort[3].available,SC.crack2.newActive,SC.crack2.oldActive,SC.T8b.localCondition,SC.T8b.enableFire,SC.T2c.localCondition,SC.T2c.enableFire,SC.T3c.localCondition,SC.T3c.enableFire,SP_new.nextTimeEvent,SP_new.nextTimeEventScaled,SC.T2.t_start,SC.T3.t_start,SC.T6.t_start,SC.T7.t_start,SC.T1.t_start,SC.T5.t_start,SC.T2b.t_start,SC.T3b.t_start,SC.T8.t_start,SC.T8b.t_start,SC.T2c.t_start,SC.T3c.t_start)
 * Number of discrete states: 25 (SC.T3c.t_start,SC.T2c.t_start,SC.T8b.t_start,SC.T8.t_start,SC.T3b.t_start,SC.T2b.t_start,SC.T5.t_start,SC.T1.t_start,SC.T7.t_start,SC.T6.t_start,SC.T3.t_start,SC.T2.t_start,SP_new.nextTimeEvent,SC_usable.nextTimeEvent,TMY_and_control.nextTimeEvent,SC.closed.newActive,SC.opening_ColdDay.newActive,SC.open.newActive,SC.opening_WarmDay.newActive,SC.closing_ColdDay.newActive,SC.crack.newActive,SC.crack2.newActive,SP_new.nextTimeEventScaled,SC_usable.nextTimeEventScaled,TMY_and_control.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1541):
 * Single equations (assignments): 1498
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 5
 * When equations: 35
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.8387/13.22, allocations: 0.5827 GB / 5.549 GB, free: 160 MB / 1.67 GB
Notification: Performance of simCode: created initialization part: time 0.1418/13.36, allocations: 116.4 MB / 5.663 GB, free: 43.57 MB / 1.67 GB
Notification: Performance of simCode: created event and clocks part: time 7.564e-06/13.36, allocations: 0 / 5.663 GB, free: 43.57 MB / 1.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.3474/13.71, allocations: 68.18 MB / 5.729 GB, free: 1.234 GB / 1.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0246/13.74, allocations: 3.056 MB / 5.732 GB, free: 1.233 GB / 1.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 1.019/14.75, allocations: 467.9 MB / 6.189 GB, free: 0.7991 GB / 1.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02164/14.78, allocations: 12.86 MB / 6.202 GB, free: 0.7865 GB / 1.67 GB
Notification: Performance of simCode: alias equations: time 0.01458/14.79, allocations: 3.178 MB / 6.205 GB, free: 0.7834 GB / 1.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01644/14.81, allocations: 10.01 MB / 6.215 GB, free: 0.7736 GB / 1.67 GB
Notification: Performance of SimCode: time 1.492e-06/14.81, allocations: 3.938 kB / 6.215 GB, free: 0.7736 GB / 1.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.6589/15.47, allocations: 0.6038 GB / 6.818 GB, free: 173.9 MB / 1.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 146.1/161.6, allocations: 11.95 kB / 6.818 GB, free: 173.9 MB / 1.67 GB
"
[Timeout remaining time 498]
(rm -f Greenhouses_Greenhouses.Examples.Greenhouse_1.pipe ; mkfifo Greenhouses_Greenhouses.Examples.Greenhouse_1.pipe ; head -c 1048576 < Greenhouses_Greenhouses.Examples.Greenhouse_1.pipe >> ../files/Greenhouses_Greenhouses.Examples.Greenhouse_1.sim & python3 -m fmpy simulate  --output-file Greenhouses_Greenhouses.Examples.Greenhouse_1_res.csv --start-time 0 --stop-time 3600 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1.44 Greenhouses_Greenhouses_Examples_Greenhouse_1.fmu > Greenhouses_Greenhouses.Examples.Greenhouse_1.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 164.59708941500867]
Failed to read output from testmodel.py, exit status != 0:
162.026317611002 162.042086278 161.075434616
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb5c909d240>