Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.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/BuildSysPro 3.5.0-master/package.mo", uses=false)
Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.5.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: "" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007521/0.000752, allocations: 92.31 kB / 15.06 MB, free: 1.098 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.0007536/0.0007537, allocations: 172.7 kB / 15.95 MB, free: 208 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.32/1.32, allocations: 223.3 MB / 240 MB, free: 5.238 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.5.0-master/package.mo): time 0.975/0.975, allocations: 143.4 MB / 434.4 MB, free: 13.63 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000315/0.000315, allocations: 16 kB / 0.5161 GB, free: 11.22 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1642/0.1645, allocations: 83.41 MB / 0.5975 GB, free: 7.75 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading): time 0.3424/0.5069, allocations: 51.52 MB / 0.6478 GB, free: 11.84 MB / 0.4981 GB
Notification: Performance of NFInst.instExpressions: time 0.01873/0.5257, allocations: 16.83 MB / 0.6643 GB, free: 15.84 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002879/0.5287, allocations: 64.12 kB / 0.6643 GB, free: 15.82 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.002365/0.531, allocations: 0.6304 MB / 0.665 GB, free: 15.47 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.006681/0.5377, allocations: 1.989 MB / 0.6669 GB, free: 14.32 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003902/0.5417, allocations: 1.088 MB / 0.668 GB, free: 13.8 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.03305/0.5747, allocations: 23.63 MB / 0.691 GB, free: 4.285 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01572/0.5905, allocations: 7.149 MB / 0.698 GB, free: 1.441 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01386/0.6044, allocations: 5.293 MB / 0.7032 GB, free: 14.84 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01299/0.6174, allocations: 5.484 MB / 0.7085 GB, free: 10.43 MB / 0.5294 GB
Notification: Performance of NFPackage.collectConstants: time 0.002452/0.6199, allocations: 352 kB / 0.7089 GB, free: 10.09 MB / 0.5294 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006964/0.6269, allocations: 0.7841 MB / 0.7096 GB, free: 9.301 MB / 0.5294 GB
Notification: Performance of NFScalarize.scalarize: time 0.00371/0.6307, allocations: 1.522 MB / 0.7111 GB, free: 7.773 MB / 0.5294 GB
Notification: Performance of NFVerifyModel.verify: time 0.004803/0.6355, allocations: 1.607 MB / 0.7127 GB, free: 6.156 MB / 0.5294 GB
Notification: Performance of NFConvertDAE.convert: time 0.01398/0.6495, allocations: 10.99 MB / 0.7234 GB, free: 11.14 MB / 0.545 GB
Notification: Performance of FrontEnd - DAE generated: time 6.031e-06/0.6495, allocations: 0 / 0.7234 GB, free: 11.14 MB / 0.545 GB
Notification: Performance of FrontEnd: time 2.064e-06/0.6495, allocations: 0 / 0.7234 GB, free: 11.14 MB / 0.545 GB
Notification: Performance of Transformations before backend: time 0.0005209/0.6501, allocations: 0 / 0.7234 GB, free: 11.14 MB / 0.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1564
 * Number of variables: 1564
Notification: Performance of Generate backend data structure: time 0.01708/0.6672, allocations: 6.966 MB / 0.7302 GB, free: 4.082 MB / 0.545 GB
Notification: Performance of prepare preOptimizeDAE: time 4.525e-05/0.6672, allocations: 12.03 kB / 0.7302 GB, free: 4.07 MB / 0.545 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003127/0.6703, allocations: 0.842 MB / 0.7311 GB, free: 3.219 MB / 0.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004461/0.6748, allocations: 0.8577 MB / 0.7319 GB, free: 2.352 MB / 0.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01429/0.6891, allocations: 6.479 MB / 0.7382 GB, free: 11.82 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005604/0.6897, allocations: 460.2 kB / 0.7387 GB, free: 11.37 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002358/0.6921, allocations: 0.6014 MB / 0.7393 GB, free: 10.77 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0239/0.716, allocations: 8.985 MB / 0.748 GB, free: 1.457 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003208/0.7164, allocations: 27.86 kB / 0.7481 GB, free: 1.43 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001855/0.7183, allocations: 260 kB / 0.7483 GB, free: 1.176 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002201/0.7185, allocations: 176 kB / 0.7485 GB, free: 1.004 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01835/0.7369, allocations: 7.418 MB / 0.7557 GB, free: 9.574 MB / 0.5762 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.05653/0.7934, allocations: 35.98 MB / 0.7909 GB, free: 3.543 MB / 0.6075 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006939/0.8004, allocations: 4.274 MB / 0.795 GB, free: 15.27 MB / 0.6231 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005024/0.8055, allocations: 3.378 MB / 0.7983 GB, free: 11.88 MB / 0.6231 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00133/0.8068, allocations: 0.9857 MB / 0.7993 GB, free: 10.71 MB / 0.6231 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004358/0.8112, allocations: 2.375 MB / 0.8016 GB, free: 8.297 MB / 0.6231 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002916/0.8142, allocations: 443.8 kB / 0.802 GB, free: 7.859 MB / 0.6231 GB
Notification: Performance of pre-optimization done (n=317): time 1.135e-05/0.8142, allocations: 0 / 0.802 GB, free: 7.859 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=317): time 0.0138/0.828, allocations: 7.094 MB / 0.809 GB, free: 0.6758 MB / 0.6231 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.122e-05/0.8281, allocations: 85.91 kB / 0.809 GB, free: 0.5781 MB / 0.6231 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01169/0.8398, allocations: 5.416 MB / 0.8143 GB, free: 11.18 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 0.001256/0.8411, allocations: 85.7 kB / 0.8144 GB, free: 11.09 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004429/0.8456, allocations: 3.2 MB / 0.8175 GB, free: 7.859 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002067/0.8477, allocations: 1.125 MB / 0.8186 GB, free: 6.719 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006844/0.8484, allocations: 88 kB / 0.8187 GB, free: 6.633 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 0.0004316/0.8488, allocations: 487.6 kB / 0.8192 GB, free: 6.148 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004084/0.8529, allocations: 2.144 MB / 0.8213 GB, free: 3.996 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005115/0.858, allocations: 3.674 MB / 0.8249 GB, free: 15.62 MB / 0.6544 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004901/0.863, allocations: 2.9 MB / 0.8277 GB, free: 12.7 MB / 0.6544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.066e-05/0.863, allocations: 16 kB / 0.8277 GB, free: 12.69 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=569) (initialization): time 0.01308/0.8761, allocations: 6.729 MB / 0.8343 GB, free: 5.906 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 8.548e-05/0.8762, allocations: 61.59 kB / 0.8343 GB, free: 5.84 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.652e-05/0.8763, allocations: 48 kB / 0.8344 GB, free: 5.793 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001028/0.8774, allocations: 441.7 kB / 0.8348 GB, free: 5.355 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003552/0.8809, allocations: 1.01 MB / 0.8358 GB, free: 4.344 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005584/0.8865, allocations: 5.251 MB / 0.8409 GB, free: 14.82 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005283/0.8918, allocations: 466.8 kB / 0.8414 GB, free: 14.37 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006689/0.8925, allocations: 220 kB / 0.8416 GB, free: 14.15 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 222
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,$PRE.pulse.T_start,pulse.T_start,$PRE.pulse.count,pulse.count,dHTan.local_reset,dHTanEnh.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (540):
 * Single equations (assignments): 537
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(1,100.0%) 14,(1,100.0%) 14}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.00489/0.8974, allocations: 2.479 MB / 0.844 GB, free: 11.66 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001713/0.8991, allocations: 0.5287 MB / 0.8445 GB, free: 11.12 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009847/0.909, allocations: 5.239 MB / 0.8496 GB, free: 5.844 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.89e-05/0.9091, allocations: 32 kB / 0.8497 GB, free: 5.812 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.339e-05/0.9091, allocations: 4 kB / 0.8497 GB, free: 5.809 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006911/0.916, allocations: 4.52 MB / 0.8541 GB, free: 1.184 MB / 0.67 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 postOpt removeSimpleEquations (simulation): time 0.5719/1.488, allocations: 11.96 MB / 0.8658 GB, free: 187.8 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.076e-05/1.488, allocations: 2.625 kB / 0.8658 GB, free: 187.8 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002406/1.49, allocations: 0.6624 MB / 0.8664 GB, free: 187.7 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006893/1.491, allocations: 370.5 kB / 0.8668 GB, free: 187.6 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001872/1.491, allocations: 84.27 kB / 0.8668 GB, free: 187.6 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003979/1.495, allocations: 5.164 MB / 0.8719 GB, free: 183.9 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.984e-06/1.495, allocations: 3.938 kB / 0.8719 GB, free: 183.9 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009895/1.505, allocations: 7.601 MB / 0.8793 GB, free: 181.1 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00277/1.508, allocations: 1.228 MB / 0.8805 GB, free: 180.5 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006622/1.509, allocations: 63.08 kB / 0.8806 GB, free: 180.5 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002965/1.512, allocations: 469 kB / 0.881 GB, free: 180.4 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003392/1.512, allocations: 200.7 kB / 0.8812 GB, free: 180.4 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002451/1.512, allocations: 142.3 kB / 0.8814 GB, free: 180.4 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.0053/1.517, allocations: 3.766 MB / 0.885 GB, free: 179.1 MB / 0.67 GB
Notification: Performance of sort global known variables: time 1.5e-07/1.518, allocations: 0 / 0.885 GB, free: 179.1 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.00571/1.523, allocations: 1.985 MB / 0.887 GB, free: 178.8 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 16 (tanEnh.vol[1].dynBal.U,tanEnh.vol[2].dynBal.U,tanEnh.vol[3].dynBal.U,tanEnh.vol[4].dynBal.U,tanEnh.vol[5].dynBal.U,tanEnh.vol[6].dynBal.U,tanEnh.vol[7].dynBal.U,tan.vol[1].dynBal.U,tan.vol[2].dynBal.U,tan.vol[3].dynBal.U,tan.vol[4].dynBal.U,tan.vol[5].dynBal.U,tan.vol[6].dynBal.U,tan.vol[7].dynBal.U,dHTanEnh.y,dHTan.y)
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (296):
 * Single equations (assignments): 289
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(1,100.0%) 14,(1,100.0%) 14}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0114/1.535, allocations: 8.539 MB / 0.8953 GB, free: 175.2 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.008337/1.543, allocations: 5.354 MB / 0.9005 GB, free: 173.2 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 9.498e-06/1.543, allocations: 3.969 kB / 0.9005 GB, free: 173.2 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.003528/1.547, allocations: 2.505 MB / 0.903 GB, free: 172.1 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0142/1.561, allocations: 3.227 MB / 0.9061 GB, free: 171.5 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1219/1.683, allocations: 51.24 MB / 0.9562 GB, free: 135 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003705/1.686, allocations: 4.629 MB / 0.9607 GB, free: 130.8 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.00673/1.693, allocations: 1.996 MB / 0.9626 GB, free: 128.8 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004118/1.697, allocations: 2.655 MB / 0.9652 GB, free: 126.2 MB / 0.67 GB
Notification: Performance of SimCode: time 1.12e-05/1.697, allocations: 4 kB / 0.9652 GB, free: 126.2 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5095/2.207, allocations: 169.4 MB / 1.131 GB, free: 190.8 MB / 0.7013 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001535/2.207, allocations: 268.2 kB / 1.131 GB, free: 190.5 MB / 0.7013 GB
Notification: Performance of buildModelFMU: Generate platform static: time 5.352/7.559, allocations: 0 / 1.131 GB, free: 190.5 MB / 0.7013 GB
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_BuildSysPro_BuildSysPro_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading_fmu --startTime=0 --stopTime=14400 --timeout=50 --tolerance=1e-06 BuildSysPro_BuildSysPro_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe 2>&1)
Environment - environmentSimulation: