Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.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.001253/0.001253, allocations: 104.4 kB / 19.7 MB, free: 2.125 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.001376/0.001376, allocations: 216.9 kB / 22.99 MB, free: 4.945 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.393/1.393, allocations: 230.6 MB / 256.8 MB, free: 7.805 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo", uses=false) [Timeout 180] "[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo): time 0.9121/0.9121, allocations: 145 MB / 458.2 MB, free: 15.28 MB / 366.1 MB " [Timeout remaining time 179] Using package BuildSysPro with version 3.6.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/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(BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay") translateModel(BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay") [Timeout 660] "Notification: BuildSysPro 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.002041/0.002041, allocations: 74.45 kB / 0.6343 GB, free: 6.188 MB / 462.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.165/0.1671, allocations: 87.88 MB / 0.7201 GB, free: 14.32 MB / 0.545 GB Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay): time 0.5415/0.7086, allocations: 162 MB / 0.8783 GB, free: 8.801 MB / 0.6544 GB Notification: Performance of NFInst.instExpressions: time 0.008441/0.717, allocations: 4.585 MB / 0.8828 GB, free: 4.203 MB / 0.6544 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001048/0.718, allocations: 39.62 kB / 0.8828 GB, free: 4.164 MB / 0.6544 GB Notification: Performance of NFTyping.typeComponents: time 0.001324/0.7194, allocations: 417.5 kB / 0.8832 GB, free: 3.754 MB / 0.6544 GB Notification: Performance of NFTyping.typeBindings: time 0.003978/0.7233, allocations: 1.459 MB / 0.8847 GB, free: 2.289 MB / 0.6544 GB Notification: Performance of NFTyping.typeClassSections: time 0.002313/0.7257, allocations: 0.7984 MB / 0.8854 GB, free: 1.5 MB / 0.6544 GB Notification: Performance of NFFlatten.flatten: time 0.002747/0.7284, allocations: 1.875 MB / 0.8873 GB, free: 15.62 MB / 0.67 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0007053/0.7291, allocations: 476.6 kB / 0.8877 GB, free: 15.14 MB / 0.67 GB Notification: Performance of NFEvalConstants.evaluate: time 0.001751/0.7309, allocations: 0.9068 MB / 0.8886 GB, free: 14.23 MB / 0.67 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001255/0.7321, allocations: 0.5667 MB / 0.8892 GB, free: 13.66 MB / 0.67 GB Notification: Performance of NFPackage.collectConstants: time 0.0001093/0.7322, allocations: 60 kB / 0.8892 GB, free: 13.61 MB / 0.67 GB Notification: Performance of NFFlatten.collectFunctions: time 0.00238/0.7346, allocations: 1.161 MB / 0.8904 GB, free: 12.44 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.000364/0.735, allocations: 275.1 kB / 0.8906 GB, free: 12.17 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.0004415/0.7354, allocations: 330.5 kB / 0.8909 GB, free: 11.85 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.002451/0.7379, allocations: 1.444 MB / 0.8924 GB, free: 10.4 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 4.709e-06/0.7379, allocations: 0 / 0.8924 GB, free: 10.4 MB / 0.67 GB Notification: Performance of FrontEnd: time 1.423e-06/0.7379, allocations: 0 / 0.8924 GB, free: 10.4 MB / 0.67 GB Notification: Performance of Transformations before backend: time 1.051e-05/0.7379, allocations: 0 / 0.8924 GB, free: 10.4 MB / 0.67 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 113 * Number of variables: 113 Notification: Performance of Generate backend data structure: time 0.001811/0.7397, allocations: 1.06 MB / 0.8934 GB, free: 9.305 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 3.468e-05/0.7397, allocations: 8.031 kB / 0.8934 GB, free: 9.297 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001304/0.741, allocations: 207.4 kB / 0.8936 GB, free: 9.094 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001118/0.7421, allocations: 0.5523 MB / 0.8941 GB, free: 8.52 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.646e-05/0.7422, allocations: 33 kB / 0.8942 GB, free: 8.488 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 9.856e-05/0.7423, allocations: 51.94 kB / 0.8942 GB, free: 8.438 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009886/0.7433, allocations: 0.6412 MB / 0.8948 GB, free: 7.754 MB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.019e-05/0.7433, allocations: 0 / 0.8948 GB, free: 7.754 MB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.962e-05/0.7433, allocations: 23.94 kB / 0.8949 GB, free: 7.73 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.267e-05/0.7434, allocations: 17 kB / 0.8949 GB, free: 7.711 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000809/0.7442, allocations: 435.7 kB / 0.8953 GB, free: 7.285 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 preOpt removeSimpleEquations (simulation): time 0.00242/0.7466, allocations: 1.246 MB / 0.8965 GB, free: 6 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0006387/0.7472, allocations: 323.5 kB / 0.8968 GB, free: 5.676 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0003429/0.7476, allocations: 198.1 kB / 0.897 GB, free: 5.48 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0002343/0.7478, allocations: 44.25 kB / 0.897 GB, free: 5.438 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.124e-05/0.7479, allocations: 38.72 kB / 0.8971 GB, free: 5.391 MB / 0.67 GB Notification: Performance of pre-optimization done (n=33): time 1.934e-06/0.7479, allocations: 0 / 0.8971 GB, free: 5.391 MB / 0.67 GB Notification: Performance of matching and sorting (n=33): time 0.001306/0.7492, allocations: 0.5457 MB / 0.8976 GB, free: 4.84 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.477e-05/0.7492, allocations: 55.41 kB / 0.8977 GB, free: 4.773 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005536/0.7498, allocations: 470.8 kB / 0.8981 GB, free: 4.301 MB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 4.176e-05/0.7498, allocations: 41.7 kB / 0.8982 GB, free: 4.254 MB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.0002423/0.7501, allocations: 312.5 kB / 0.8985 GB, free: 3.945 MB / 0.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.00012/0.7502, allocations: 114.9 kB / 0.8986 GB, free: 3.832 MB / 0.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.000114/0.7503, allocations: 74.02 kB / 0.8986 GB, free: 3.754 MB / 0.67 GB Notification: Performance of setup shared object (initialization): time 0.0001854/0.7505, allocations: 362.7 kB / 0.899 GB, free: 3.391 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002857/0.7508, allocations: 142.1 kB / 0.8991 GB, free: 3.25 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004401/0.7512, allocations: 374.3 kB / 0.8995 GB, free: 2.824 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0005944/0.7518, allocations: 348.1 kB / 0.8998 GB, free: 2.473 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.615e-06/0.7518, allocations: 0 / 0.8998 GB, free: 2.473 MB / 0.67 GB Notification: Performance of matching and sorting (n=39) (initialization): time 0.0007434/0.7525, allocations: 421 kB / 0.9002 GB, free: 2.055 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 1.671e-05/0.7526, allocations: 4 kB / 0.9002 GB, free: 2.051 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.927e-06/0.7526, allocations: 4.859 kB / 0.9002 GB, free: 2.047 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.911e-05/0.7526, allocations: 8.094 kB / 0.9002 GB, free: 2.039 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003417/0.7529, allocations: 71.84 kB / 0.9003 GB, free: 1.969 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 6.742e-06/0.7529, allocations: 0 / 0.9003 GB, free: 1.969 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004286/0.7534, allocations: 39.77 kB / 0.9003 GB, free: 1.93 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.741e-05/0.7534, allocations: 15.98 kB / 0.9003 GB, free: 1.914 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0004903/0.7539, allocations: 308 kB / 0.9006 GB, free: 1.609 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004199/0.7543, allocations: 369.5 kB / 0.901 GB, free: 1.188 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005673/0.7549, allocations: 331.9 kB / 0.9013 GB, free: 0.8516 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.146e-06/0.7549, allocations: 4 kB / 0.9013 GB, free: 0.8477 MB / 0.67 GB Notification: Performance of matching and sorting (n=39) (initialization_lambda0): time 0.0007117/0.7556, allocations: 417 kB / 0.9017 GB, free: 444 kB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 9.798e-06/0.7556, allocations: 4 kB / 0.9017 GB, free: 440 kB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.739e-06/0.7556, allocations: 9.656 kB / 0.9017 GB, free: 432 kB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.476e-06/0.7556, allocations: 0 / 0.9017 GB, free: 432 kB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003161/0.7559, allocations: 71.91 kB / 0.9018 GB, free: 360 kB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.176e-06/0.7559, allocations: 0 / 0.9018 GB, free: 360 kB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004156/0.7563, allocations: 36.69 kB / 0.9018 GB, free: 324 kB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.565e-05/0.7564, allocations: 16 kB / 0.9018 GB, free: 308 kB / 0.67 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 4 * 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 (39): * Single equations (assignments): 39 * 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.000165/0.7565, allocations: 200.1 kB / 0.902 GB, free: 100 kB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 9.513e-05/0.7566, allocations: 55.67 kB / 0.9021 GB, free: 44 kB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008352/0.7575, allocations: 430.4 kB / 0.9025 GB, free: 15.62 MB / 0.6856 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.402e-06/0.7575, allocations: 4 kB / 0.9025 GB, free: 15.61 MB / 0.6856 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.478e-06/0.7575, allocations: 0 / 0.9025 GB, free: 15.61 MB / 0.6856 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006449/0.7581, allocations: 433.6 kB / 0.9029 GB, free: 15.16 MB / 0.6856 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001817/0.7599, allocations: 1.014 MB / 0.9039 GB, free: 14.09 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.023e-06/0.7599, allocations: 6.875 kB / 0.9039 GB, free: 14.09 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004051/0.7604, allocations: 79.89 kB / 0.904 GB, free: 14.01 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.101e-05/0.7604, allocations: 7.938 kB / 0.904 GB, free: 14 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.085e-05/0.7604, allocations: 8 kB / 0.904 GB, free: 13.99 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.156e-06/0.7604, allocations: 0 / 0.904 GB, free: 13.99 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.382e-06/0.7604, allocations: 7.984 kB / 0.904 GB, free: 13.98 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00114/0.7615, allocations: 0.7076 MB / 0.9047 GB, free: 13.24 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0002672/0.7618, allocations: 103.5 kB / 0.9048 GB, free: 13.14 MB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.759e-05/0.7619, allocations: 11.98 kB / 0.9048 GB, free: 13.13 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004235/0.7623, allocations: 19.98 kB / 0.9048 GB, free: 13.11 MB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 7.015e-05/0.7624, allocations: 31.89 kB / 0.9049 GB, free: 13.08 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.033e-05/0.7624, allocations: 19.92 kB / 0.9049 GB, free: 13.06 MB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.0003917/0.7628, allocations: 330.9 kB / 0.9052 GB, free: 12.74 MB / 0.6856 GB Notification: Performance of sort global known variables: time 1e-07/0.7628, allocations: 0 / 0.9052 GB, free: 12.74 MB / 0.6856 GB Notification: Performance of remove unused functions: time 0.000846/0.7636, allocations: 331.3 kB / 0.9055 GB, free: 12.41 MB / 0.6856 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 7 * Number of states: 3 (del.dynBal.medium.Xi[1],del.dynBal.U,del.dynBal.m) * 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 (33): * Single equations (assignments): 33 * 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.0003078/0.7639, allocations: 175 kB / 0.9057 GB, free: 12.23 MB / 0.6856 GB Notification: Performance of simCode: created initialization part: time 0.001001/0.7649, allocations: 0.4919 MB / 0.9062 GB, free: 11.74 MB / 0.6856 GB Notification: Performance of simCode: created event and clocks part: time 2.705e-06/0.765, allocations: 4 kB / 0.9062 GB, free: 11.74 MB / 0.6856 GB Notification: Performance of simCode: created simulation system equations: time 0.0003315/0.7653, allocations: 175.7 kB / 0.9063 GB, free: 11.57 MB / 0.6856 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001428/0.7667, allocations: 339.6 kB / 0.9067 GB, free: 11.25 MB / 0.6856 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002032/0.7687, allocations: 1.297 MB / 0.9079 GB, free: 9.902 MB / 0.6856 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000349/0.7691, allocations: 340.4 kB / 0.9082 GB, free: 9.543 MB / 0.6856 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001563/0.7692, allocations: 47.44 kB / 0.9083 GB, free: 9.496 MB / 0.6856 GB Notification: Performance of SimCode: time 6.11e-07/0.7692, allocations: 0 / 0.9083 GB, free: 9.496 MB / 0.6856 GB Notification: Performance of Templates: time 0.01495/0.7842, allocations: 9.734 MB / 0.9178 GB, free: 15.85 MB / 0.7012 GB " [Timeout remaining time 659] make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.makefile [Timeout 660] (rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.Delays.Examples.Delay.pipe 2>&1) [Timeout 480] [Calling sys.exit(0), Time elapsed: 9.905035035684705] Failed to read output from testmodel.py, exit status != 0: 0.7928369180299342 0.8074040650000001 0.066349671 Calling exit ...