Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.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.0007793/0.0007793, allocations: 79.7 kB / 20.67 MB, free: 3.891 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.0007523/0.0007523, allocations: 174 kB / 23.95 MB, free: 0.6094 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 0.8463/0.8463, allocations: 177.1 MB / 204.3 MB, free: 5.723 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo): time 0.563/0.563, allocations: 88.07 MB / 348.8 MB, free: 14.38 MB / 330.7 MB " [Timeout remaining time 179] Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 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(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80,fileNamePrefix="ScalableTestSuite_ScalableTestSuite_Thermal_DistrictHeating_ScaledExperiments_HeatingSystem_N_80",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80,fileNamePrefix="ScalableTestSuite_ScalableTestSuite_Thermal_DistrictHeating_ScaledExperiments_HeatingSystem_N_80",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 1.453e-06/1.453e-06, allocations: 0 / 0.5246 GB, free: 2.379 MB / 442.8 MB Notification: Performance of FrontEnd - Absyn->SCode: time 1.638e-05/1.783e-05, allocations: 3.828 kB / 0.5246 GB, free: 2.375 MB / 442.8 MB Notification: Performance of NFInst.instantiate(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80): time 0.001626/0.001643, allocations: 1.377 MB / 0.526 GB, free: 0.9883 MB / 442.8 MB Notification: Performance of NFInst.instExpressions: time 0.0009089/0.002552, allocations: 0.5146 MB / 0.5265 GB, free: 484 kB / 442.8 MB Notification: Performance of NFInst.updateImplicitVariability: time 4.274e-05/0.002595, allocations: 7.938 kB / 0.5265 GB, free: 476 kB / 442.8 MB Notification: Performance of NFTyping.typeComponents: time 7.889e-05/0.002674, allocations: 11.92 kB / 0.5265 GB, free: 464 kB / 442.8 MB Notification: Performance of NFTyping.typeBindings: time 0.0002829/0.002957, allocations: 63.59 kB / 0.5265 GB, free: 400 kB / 442.8 MB Notification: Performance of NFTyping.typeClassSections: time 7.245e-05/0.003029, allocations: 39.81 kB / 0.5266 GB, free: 360 kB / 442.8 MB Notification: Performance of NFFlatten.flatten: time 0.001007/0.004036, allocations: 1.985 MB / 0.5285 GB, free: 14.36 MB / 458.8 MB Notification: Performance of NFFlatten.resolveConnections: time 8.895e-05/0.004125, allocations: 16.19 kB / 0.5285 GB, free: 14.35 MB / 458.8 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0006623/0.004788, allocations: 0.8974 MB / 0.5294 GB, free: 13.45 MB / 458.8 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0007537/0.005541, allocations: 0.9521 MB / 0.5303 GB, free: 12.49 MB / 458.8 MB Notification: Performance of NFPackage.collectConstants: time 0.0001531/0.005694, allocations: 116 kB / 0.5305 GB, free: 12.38 MB / 458.8 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0002408/0.005935, allocations: 144 kB / 0.5306 GB, free: 12.24 MB / 458.8 MB Notification: Performance of NFScalarize.scalarize: time 0.0005365/0.006472, allocations: 0.9264 MB / 0.5315 GB, free: 11.31 MB / 458.8 MB Notification: Performance of NFVerifyModel.verify: time 0.0005027/0.006974, allocations: 0.6859 MB / 0.5322 GB, free: 10.62 MB / 458.8 MB Notification: Performance of NFConvertDAE.convert: time 0.001096/0.008071, allocations: 1.772 MB / 0.5339 GB, free: 8.848 MB / 458.8 MB Notification: Performance of FrontEnd - DAE generated: time 5.53e-06/0.008076, allocations: 0 / 0.5339 GB, free: 8.848 MB / 458.8 MB Notification: Performance of FrontEnd: time 3.576e-06/0.00808, allocations: 0 / 0.5339 GB, free: 8.848 MB / 458.8 MB Notification: Performance of Transformations before backend: time 2.295e-05/0.008103, allocations: 4 kB / 0.5339 GB, free: 8.844 MB / 458.8 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 403 * Number of variables: 403 Notification: Performance of Generate backend data structure: time 0.002738/0.01084, allocations: 2.176 MB / 0.536 GB, free: 6.629 MB / 458.8 MB Notification: Performance of prepare preOptimizeDAE: time 4.303e-05/0.01088, allocations: 12.03 kB / 0.536 GB, free: 6.617 MB / 458.8 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002109/0.0111, allocations: 240.4 kB / 0.5363 GB, free: 6.371 MB / 458.8 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002306/0.01133, allocations: 171.9 kB / 0.5364 GB, free: 6.203 MB / 458.8 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.000798/0.01212, allocations: 0.6935 MB / 0.5371 GB, free: 5.48 MB / 458.8 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.912e-05/0.01218, allocations: 123.5 kB / 0.5372 GB, free: 5.359 MB / 458.8 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002396/0.01242, allocations: 231.6 kB / 0.5375 GB, free: 5.133 MB / 458.8 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.00225/0.01467, allocations: 2.239 MB / 0.5396 GB, free: 2.875 MB / 458.8 MB Notification: Performance of preOpt findStateOrder (simulation): time 2.178e-05/0.01469, allocations: 0 / 0.5396 GB, free: 2.875 MB / 458.8 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001263/0.01482, allocations: 64 kB / 0.5397 GB, free: 2.812 MB / 458.8 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.002e-05/0.01484, allocations: 36 kB / 0.5397 GB, free: 2.777 MB / 458.8 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002573/0.01741, allocations: 2.897 MB / 0.5426 GB, free: 15.88 MB / 474.8 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.00183/0.01924, allocations: 1.868 MB / 0.5444 GB, free: 13.96 MB / 474.8 MB Notification: Performance of preOpt comSubExp (simulation): time 0.006953/0.0262, allocations: 5.548 MB / 0.5498 GB, free: 8.371 MB / 474.8 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001666/0.02786, allocations: 1.665 MB / 0.5514 GB, free: 6.699 MB / 474.8 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0002246/0.02809, allocations: 55.17 kB / 0.5515 GB, free: 6.645 MB / 474.8 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.213e-05/0.02813, allocations: 77.67 kB / 0.5516 GB, free: 6.559 MB / 474.8 MB Notification: Performance of pre-optimization done (n=403): time 4.679e-06/0.02813, allocations: 0 / 0.5516 GB, free: 6.559 MB / 474.8 MB Notification: Performance of matching and sorting (n=403): time 0.005549/0.03368, allocations: 5.245 MB / 0.5567 GB, free: 1.289 MB / 474.8 MB Notification: Performance of inlineWhenForInitialization (initialization): time 5.875e-05/0.03374, allocations: 94.56 kB / 0.5568 GB, free: 1.184 MB / 474.8 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002335/0.03398, allocations: 345.7 kB / 0.5571 GB, free: 0.8398 MB / 474.8 MB Notification: Performance of collectPreVariables (initialization): time 0.0001173/0.03409, allocations: 93.7 kB / 0.5572 GB, free: 0.7422 MB / 474.8 MB Notification: Performance of collectInitialEqns (initialization): time 8.279e-05/0.03418, allocations: 170.4 kB / 0.5574 GB, free: 0.5703 MB / 474.8 MB Notification: Performance of collectInitialBindings (initialization): time 0.0007483/0.03492, allocations: 1.615 MB / 0.5589 GB, free: 14.94 MB / 490.8 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006753/0.0356, allocations: 0.7261 MB / 0.5596 GB, free: 14.2 MB / 490.8 MB Notification: Performance of setup shared object (initialization): time 0.0001007/0.0357, allocations: 338 kB / 0.56 GB, free: 13.86 MB / 490.8 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001915/0.03762, allocations: 1.831 MB / 0.5617 GB, free: 12.02 MB / 490.8 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001942/0.03956, allocations: 1.901 MB / 0.5636 GB, free: 10.11 MB / 490.8 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.004096/0.04365, allocations: 4.125 MB / 0.5676 GB, free: 5.914 MB / 490.8 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.464e-06/0.04366, allocations: 0 / 0.5676 GB, free: 5.914 MB / 490.8 MB Notification: Performance of matching and sorting (n=564) (initialization): time 0.004901/0.04856, allocations: 4.832 MB / 0.5724 GB, free: 0.9961 MB / 490.8 MB Notification: Performance of prepare postOptimizeDAE: time 3.115e-05/0.04859, allocations: 4 kB / 0.5724 GB, free: 0.9922 MB / 490.8 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.536e-05/0.04861, allocations: 3.984 kB / 0.5724 GB, free: 0.9883 MB / 490.8 MB Notification: Performance of postOpt tearingSystem (initialization): time 3.161e-05/0.04864, allocations: 20 kB / 0.5724 GB, free: 0.9688 MB / 490.8 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002002/0.05064, allocations: 1.034 MB / 0.5734 GB, free: 15.93 MB / 0.4949 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.15e-05/0.05067, allocations: 16 kB / 0.5734 GB, free: 15.92 MB / 0.4949 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006844/0.05136, allocations: 297.6 kB / 0.5737 GB, free: 15.62 MB / 0.4949 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001968/0.05156, allocations: 159.9 kB / 0.5738 GB, free: 15.47 MB / 0.4949 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 1 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (564): * Single equations (assignments): 564 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.000627/0.05218, allocations: 0.489 MB / 0.5743 GB, free: 14.97 MB / 0.4949 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002204/0.0524, allocations: 175 kB / 0.5745 GB, free: 14.8 MB / 0.4949 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005467/0.05787, allocations: 5.371 MB / 0.5797 GB, free: 9.32 MB / 0.4949 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.333e-05/0.05789, allocations: 56 kB / 0.5798 GB, free: 9.266 MB / 0.4949 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.948e-06/0.0579, allocations: 7.922 kB / 0.5798 GB, free: 9.258 MB / 0.4949 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.36e-05/0.05795, allocations: 23.91 kB / 0.5798 GB, free: 9.234 MB / 0.4949 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002142/0.06009, allocations: 2.349 MB / 0.5821 GB, free: 6.832 MB / 0.4949 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.655e-06/0.0601, allocations: 0 / 0.5821 GB, free: 6.832 MB / 0.4949 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002928/0.06302, allocations: 1.163 MB / 0.5832 GB, free: 5.668 MB / 0.4949 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.672e-05/0.06304, allocations: 16 kB / 0.5833 GB, free: 5.652 MB / 0.4949 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002121/0.06325, allocations: 191.8 kB / 0.5834 GB, free: 5.465 MB / 0.4949 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.376e-05/0.06327, allocations: 16 kB / 0.5835 GB, free: 5.449 MB / 0.4949 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.286e-06/0.06327, allocations: 11.98 kB / 0.5835 GB, free: 5.438 MB / 0.4949 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006993/0.07026, allocations: 7.181 MB / 0.5905 GB, free: 14.11 MB / 0.5105 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0007687/0.07103, allocations: 0.6687 MB / 0.5911 GB, free: 13.44 MB / 0.5105 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002375/0.07127, allocations: 147.9 kB / 0.5913 GB, free: 13.3 MB / 0.5105 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005896/0.07186, allocations: 92 kB / 0.5914 GB, free: 13.21 MB / 0.5105 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003165/0.07217, allocations: 343.7 kB / 0.5917 GB, free: 12.87 MB / 0.5105 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001691/0.07234, allocations: 159.9 kB / 0.5918 GB, free: 12.71 MB / 0.5105 GB Notification: Performance of sorting global known variables: time 0.0001485/0.07249, allocations: 247.1 kB / 0.5921 GB, free: 12.47 MB / 0.5105 GB Notification: Performance of sort global known variables: time 6e-08/0.07249, allocations: 0 / 0.5921 GB, free: 12.47 MB / 0.5105 GB Notification: Performance of remove unused functions: time 0.0009212/0.07341, allocations: 0.8633 MB / 0.5929 GB, free: 11.61 MB / 0.5105 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 161 (Td,Tu[1],Tu[2],Tu[3],Tu[4],Tu[5],Tu[6],Tu[7],Tu[8],Tu[9],Tu[10],Tu[11],Tu[12],Tu[13],Tu[14],Tu[15],Tu[16],Tu[17],Tu[18],Tu[19],Tu[20],Tu[21],Tu[22],Tu[23],Tu[24],Tu[25],Tu[26],Tu[27],Tu[28],Tu[29],Tu[30],Tu[31],Tu[32],Tu[33],Tu[34],Tu[35],Tu[36],Tu[37],Tu[38],Tu[39],Tu[40],Tu[41],Tu[42],Tu[43],Tu[44],Tu[45],Tu[46],Tu[47],Tu[48],Tu[49],Tu[50],Tu[51],Tu[52],Tu[53],Tu[54],Tu[55],Tu[56],Tu[57],Tu[58],Tu[59],Tu[60],Tu[61],Tu[62],Tu[63],Tu[64],Tu[65],Tu[66],Tu[67],Tu[68],Tu[69],Tu[70],Tu[71],Tu[72],Tu[73],Tu[74],Tu[75],Tu[76],Tu[77],Tu[78],Tu[79],Tu[80],x[1],x[2],x[3],x[4],x[5],x[6],x[7],x[8],x[9],x[10],x[11],x[12],x[13],x[14],x[15],x[16],x[17],x[18],x[19],x[20],x[21],x[22],x[23],x[24],x[25],x[26],x[27],x[28],x[29],x[30],x[31],x[32],x[33],x[34],x[35],x[36],x[37],x[38],x[39],x[40],x[41],x[42],x[43],x[44],x[45],x[46],x[47],x[48],x[49],x[50],x[51],x[52],x[53],x[54],x[55],x[56],x[57],x[58],x[59],x[60],x[61],x[62],x[63],x[64],x[65],x[66],x[67],x[68],x[69],x[70],x[71],x[72],x[73],x[74],x[75],x[76],x[77],x[78],x[79],x[80]) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (564): * Single equations (assignments): 564 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.007997/0.08141, allocations: 7.973 MB / 0.6007 GB, free: 3.484 MB / 0.5105 GB Notification: Performance of simCode: created initialization part: time 0.004499/0.08591, allocations: 4.302 MB / 0.6049 GB, free: 15.12 MB / 0.5262 GB Notification: Performance of simCode: created event and clocks part: time 3.777e-06/0.08591, allocations: 4 kB / 0.6049 GB, free: 15.12 MB / 0.5262 GB Notification: Performance of simCode: created simulation system equations: time 0.002143/0.08806, allocations: 2.375 MB / 0.6072 GB, free: 12.73 MB / 0.5262 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001091/0.08915, allocations: 393.3 kB / 0.6076 GB, free: 12.35 MB / 0.5262 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02445/0.1136, allocations: 25.71 MB / 0.6327 GB, free: 2.355 MB / 0.5418 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006247/0.1142, allocations: 1.055 MB / 0.6337 GB, free: 1.258 MB / 0.5418 GB Notification: Performance of simCode: alias equations: time 0.3888/0.503, allocations: 1.49 MB / 0.6352 GB, free: 110.1 MB / 0.5419 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001494/0.5045, allocations: 0.9574 MB / 0.6361 GB, free: 110 MB / 0.5419 GB Notification: Performance of SimCode: time 9.22e-07/0.5045, allocations: 0 / 0.6361 GB, free: 110 MB / 0.5419 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.05323/0.5577, allocations: 61.74 MB / 0.6964 GB, free: 60.89 MB / 0.5419 GB Notification: Performance of buildModelFMU: Generate platform static: time 8.46/9.018, allocations: 5.188 kB / 0.6964 GB, free: 60.89 MB / 0.5419 GB " [Timeout remaining time 291] (rm -f ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.pipe ; mkfifo ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.pipe ; head -c 1048576 < ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.pipe >> ../files/ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.sim & python3 -m fmpy simulate --output-file ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80_res.csv --start-time 0 --stop-time 432000 --timeout 300 --relative-tolerance 1e-07 --interface-type ModelExchange --solver CVode --output-interval 20 ScalableTestSuite_ScalableTestSuite_Thermal_DistrictHeating_ScaledExperiments_HeatingSystem_N_80.fmu > ScalableTestSuite_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_80.pipe 2>&1) [Timeout 315.0] [Calling os._exit(0), Time elapsed: 22.75093231908977] Failed to read output from testmodel.py, exit status != 0: 9.121451477520168 9.128287713 9.118869667 Calling exit ...