Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.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.0009374/0.0009374, allocations: 80.81 kB / 21.55 MB, free: 2.945 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.001011/0.001011, allocations: 159 kB / 24.96 MB, free: 8.758 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.9612/0.9612, allocations: 177.1 MB / 205.4 MB, free: 5.477 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.957/1.957, allocations: 389.6 MB / 0.6362 GB, free: 12.32 MB / 0.6042 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT")
translateModel(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.323e-06/1.323e-06, allocations: 0 / 0.776 GB, free: 5.348 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.198e-05/2.33e-05, allocations: 2.312 kB / 0.776 GB, free: 5.344 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT): time 0.01905/0.01907, allocations: 25.36 MB / 0.8008 GB, free: 11.93 MB / 0.7605 GB
Notification: Performance of NFInst.instExpressions: time 0.02452/0.0436, allocations: 15.41 MB / 0.8158 GB, free: 12.61 MB / 0.7761 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004578/0.04817, allocations: 230 kB / 0.8161 GB, free: 12.38 MB / 0.7761 GB
Notification: Performance of NFTyping.typeComponents: time 0.00357/0.05174, allocations: 1.177 MB / 0.8172 GB, free: 11.2 MB / 0.7761 GB
Notification: Performance of NFTyping.typeBindings: time 0.008603/0.06035, allocations: 4.266 MB / 0.8214 GB, free: 6.934 MB / 0.7761 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01582/0.07617, allocations: 11.56 MB / 0.8327 GB, free: 11.36 MB / 0.7917 GB
Notification: Performance of NFFlatten.flatten: time 0.06455/0.1407, allocations: 108.6 MB / 0.9387 GB, free: 14.44 MB / 0.9011 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05087/0.1916, allocations: 38.42 MB / 0.9762 GB, free: 7.832 MB / 0.9323 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1056/0.2971, allocations: 54.6 MB / 1.03 GB, free: 1.137 MB / 0.9792 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.8394/1.137, allocations: 36.59 MB / 1.065 GB, free: 98.7 MB / 0.9949 GB
Notification: Performance of NFPackage.collectConstants: time 0.03018/1.167, allocations: 6.32 MB / 1.071 GB, free: 98.7 MB / 0.9949 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04146/1.208, allocations: 7.099 MB / 1.078 GB, free: 98.7 MB / 0.9949 GB
Notification: Performance of NFScalarize.scalarize: time 0.04367/1.252, allocations: 35.17 MB / 1.113 GB, free: 98.59 MB / 0.9949 GB
Notification: Performance of NFVerifyModel.verify: time 0.06795/1.32, allocations: 32.65 MB / 1.145 GB, free: 91.37 MB / 0.9949 GB
Notification: Performance of NFConvertDAE.convert: time 0.1158/1.436, allocations: 80.55 MB / 1.223 GB, free: 55.64 MB / 0.9949 GB
Notification: Performance of FrontEnd - DAE generated: time 6.662e-06/1.436, allocations: 0 / 1.223 GB, free: 55.64 MB / 0.9949 GB
Notification: Performance of FrontEnd: time 1.153e-06/1.436, allocations: 0 / 1.223 GB, free: 55.64 MB / 0.9949 GB
Notification: Performance of Transformations before backend: time 0.0107/1.446, allocations: 0 / 1.223 GB, free: 55.64 MB / 0.9949 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 22767
 * Number of variables: 22767
Notification: Performance of Generate backend data structure: time 0.194/1.64, allocations: 83.62 MB / 1.305 GB, free: 7.758 MB / 1.026 GB
Notification: Performance of prepare preOptimizeDAE: time 4.834e-05/1.64, allocations: 9.344 kB / 1.305 GB, free: 7.75 MB / 1.026 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06953/1.71, allocations: 14.73 MB / 1.319 GB, free: 9.023 MB / 1.042 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.08557/1.795, allocations: 26.89 MB / 1.346 GB, free: 14.78 MB / 1.073 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.007188/1.803, allocations: 4.552 MB / 1.35 GB, free: 10.22 MB / 1.073 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.03432/1.837, allocations: 6.631 MB / 1.357 GB, free: 3.59 MB / 1.073 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2531/2.09, allocations: 95.43 MB / 1.45 GB, free: 11.71 MB / 1.182 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.002772/2.093, allocations: 273.8 kB / 1.45 GB, free: 11.45 MB / 1.182 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.02204/2.115, allocations: 2.63 MB / 1.453 GB, free: 8.816 MB / 1.182 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.008177/2.123, allocations: 12 MB / 1.464 GB, free: 12.81 MB / 1.198 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1401/2.263, allocations: 36.85 MB / 1.5 GB, free: 7.898 MB / 1.229 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 1.417/3.68, allocations: 261 MB / 1.755 GB, free: 161.1 MB / 1.229 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.1167/3.796, allocations: 63.34 MB / 1.817 GB, free: 96.11 MB / 1.229 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.05061/3.847, allocations: 17.59 MB / 1.834 GB, free: 78.48 MB / 1.229 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.3375/4.184, allocations: 91.27 MB / 1.923 GB, free: 4.824 MB / 1.245 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.07187/4.256, allocations: 44.75 MB / 1.967 GB, free: 2.48 MB / 1.292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.03006/4.286, allocations: 5.561 MB / 1.972 GB, free: 14.38 MB / 1.308 GB
Notification: Performance of pre-optimization done (n=6322): time 0.0001627/4.286, allocations: 0 / 1.972 GB, free: 14.38 MB / 1.308 GB
Notification: Performance of matching and sorting (n=6918): time 1.363/5.649, allocations: 147.4 MB / 2.116 GB, free: 393.5 MB / 1.323 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004532/5.65, allocations: 0.7409 MB / 2.117 GB, free: 393.4 MB / 1.323 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03727/5.687, allocations: 24.31 MB / 2.141 GB, free: 391.5 MB / 1.323 GB
Notification: Performance of collectPreVariables (initialization): time 0.01986/5.707, allocations: 1.35 MB / 2.142 GB, free: 391.4 MB / 1.323 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03411/5.741, allocations: 32.2 MB / 2.174 GB, free: 375.7 MB / 1.323 GB
Notification: Performance of collectInitialBindings (initialization): time 0.03784/5.779, allocations: 25.65 MB / 2.199 GB, free: 358.5 MB / 1.323 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.07017/5.849, allocations: 15.93 MB / 2.214 GB, free: 346.5 MB / 1.323 GB
Notification: Performance of setup shared object (initialization): time 4.269e-05/5.849, allocations: 305.1 kB / 2.215 GB, free: 346.2 MB / 1.323 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04508/5.894, allocations: 12.85 MB / 2.227 GB, free: 334.7 MB / 1.323 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05943/5.954, allocations: 46.26 MB / 2.272 GB, free: 275.9 MB / 1.323 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1142/6.068, allocations: 59.91 MB / 2.331 GB, free: 205.7 MB / 1.323 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001189/6.069, allocations: 240 kB / 2.331 GB, free: 205.5 MB / 1.323 GB
Notification: Performance of matching and sorting (n=11964) (initialization): time 0.1547/6.224, allocations: 52.53 MB / 2.382 GB, free: 153 MB / 1.323 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001219/6.225, allocations: 368 kB / 2.383 GB, free: 152.6 MB / 1.323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001437/6.226, allocations: 0.8278 MB / 2.383 GB, free: 151.8 MB / 1.323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001436/6.228, allocations: 1.305 MB / 2.385 GB, free: 150.5 MB / 1.323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.4552/6.683, allocations: 110.2 MB / 2.492 GB, free: 40.23 MB / 1.323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.067/7.75, allocations: 175.1 MB / 2.663 GB, free: 178.1 MB / 1.324 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06754/7.818, allocations: 4.31 MB / 2.668 GB, free: 178.1 MB / 1.324 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02723/7.845, allocations: 3.49 MB / 2.671 GB, free: 178.1 MB / 1.324 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.08258/7.928, allocations: 13.77 MB / 2.684 GB, free: 177.7 MB / 1.324 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.06776/7.996, allocations: 45.65 MB / 2.729 GB, free: 136.8 MB / 1.324 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1306/8.126, allocations: 58.65 MB / 2.786 GB, free: 103.7 MB / 1.324 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.002081/8.128, allocations: 242.1 kB / 2.787 GB, free: 103.7 MB / 1.324 GB
Notification: Performance of matching and sorting (n=11964) (initialization_lambda0): time 0.1739/8.302, allocations: 51.13 MB / 2.836 GB, free: 97.14 MB / 1.324 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000971/8.303, allocations: 368.2 kB / 2.837 GB, free: 97.14 MB / 1.324 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001365/8.304, allocations: 0.8246 MB / 2.838 GB, free: 96.59 MB / 1.324 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001366/8.306, allocations: 1.309 MB / 2.839 GB, free: 95.29 MB / 1.324 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1299/8.436, allocations: 47.71 MB / 2.885 GB, free: 60.58 MB / 1.324 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001407/8.437, allocations: 1.834 MB / 2.887 GB, free: 58.74 MB / 1.324 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06202/8.499, allocations: 4.258 MB / 2.891 GB, free: 56.05 MB / 1.324 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02436/8.523, allocations: 3.429 MB / 2.895 GB, free: 53.46 MB / 1.324 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 3849
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($PRE.DataReader.nextTimeEvent,$whenCondition1,lessThreshold.y,DataReader.nextTimeEventScaled,$PRE.DataReader.nextTimeEventScaled,DataReader.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (11964):
 * Single equations (assignments): 11672
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 292
 * Torn equation systems: 0
 * 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): 292 systems
   {1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.06201/8.585, allocations: 6.19 MB / 2.901 GB, free: 49.02 MB / 1.324 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.05382/8.639, allocations: 5.374 MB / 2.906 GB, free: 43.64 MB / 1.324 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1664/8.806, allocations: 42.13 MB / 2.947 GB, free: 2.457 MB / 1.324 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1001/8.906, allocations: 23.17 MB / 2.97 GB, free: 11.24 MB / 1.355 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002256/8.906, allocations: 4.531 kB / 2.97 GB, free: 11.24 MB / 1.355 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.04364/8.95, allocations: 10.75 MB / 2.98 GB, free: 3.32 MB / 1.355 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0245/8.974, allocations: 1.41 MB / 2.982 GB, free: 1.91 MB / 1.355 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.04652/9.021, allocations: 2.878 MB / 2.985 GB, free: 15.16 MB / 1.371 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.02182/9.042, allocations: 4.328 MB / 2.989 GB, free: 10.82 MB / 1.371 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.1767/9.219, allocations: 48.2 MB / 3.036 GB, free: 10.96 MB / 1.418 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.8566/10.08, allocations: 49.07 MB / 3.084 GB, free: 356.1 MB / 1.418 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.04987/10.13, allocations: 16.42 MB / 3.1 GB, free: 355.3 MB / 1.418 GB
Notification: Performance of sorting global known variables: time 0.02109/10.15, allocations: 10.58 MB / 3.11 GB, free: 354.6 MB / 1.418 GB
Notification: Performance of Backend: time 6.72e-07/10.15, allocations: 0.5469 kB / 3.11 GB, free: 354.6 MB / 1.418 GB
Notification: Performance of simCode: created initialization part: time 0.7484/10.9, allocations: 161.6 MB / 3.268 GB, free: 290.4 MB / 1.418 GB
Notification: Performance of SimCode: time 0.2971/11.19, allocations: 136.8 MB / 3.401 GB, free: 161.5 MB / 1.418 GB
Notification: Performance of Templates: time 3.498/14.69, allocations: 1.708 GB / 5.109 GB, free: 101.8 MB / 1.496 GB
"
[Timeout remaining time 285]
make -j1 -f Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.pipe ; mkfifo Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.pipe >> ../files/Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.sim & ./Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 292.3903794391081]