Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.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.00148/0.00148, allocations: 84.39 kB / 20.23 MB, free: 4.176 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.001874/0.001874, allocations: 161.7 kB / 23.54 MB, free: 0.8672 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 1.449/1.449, allocations: 177.1 MB / 203.9 MB, free: 5.609 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo): time 2.68/2.68, allocations: 359 MB / 0.6048 GB, free: 10.95 MB / 0.573 GB
"
[Timeout remaining time 177]
Using package Buildings with version 11.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.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.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|irRadExc.conExt.1..T|irRadExc.conExtWin.1..T|irRadExc.conExtWinFra.1..T|irRadExc.conPar_a.1..T|irRadExc.conPar_b.1..T|irRadExc.conBou.1..T|irRadExc.conSurBou.1..T",fileNamePrefix="Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange")
translateModel(Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|irRadExc.conExt.1..T|irRadExc.conExtWin.1..T|irRadExc.conExtWinFra.1..T|irRadExc.conPar_a.1..T|irRadExc.conPar_b.1..T|irRadExc.conBou.1..T|irRadExc.conSurBou.1..T",fileNamePrefix="Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.633e-06/1.633e-06, allocations: 0 / 0.7865 GB, free: 12.73 MB / 0.7448 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.486e-05/2.649e-05, allocations: 2.312 kB / 0.7865 GB, free: 12.72 MB / 0.7448 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange): time 0.009952/0.009979, allocations: 6.405 MB / 0.7927 GB, free: 6.297 MB / 0.7448 GB
Notification: Performance of NFInst.instExpressions: time 0.009402/0.01938, allocations: 5.082 MB / 0.7977 GB, free: 1.234 MB / 0.7448 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001203/0.02058, allocations: 71.94 kB / 0.7978 GB, free: 1.164 MB / 0.7448 GB
Notification: Performance of NFTyping.typeComponents: time 0.004902/0.02549, allocations: 1.607 MB / 0.7993 GB, free: 15.55 MB / 0.7605 GB
Notification: Performance of NFTyping.typeBindings: time 0.00197/0.02746, allocations: 0.6631 MB / 0.8 GB, free: 14.89 MB / 0.7605 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001285/0.02874, allocations: 393.8 kB / 0.8003 GB, free: 14.51 MB / 0.7605 GB
Notification: Performance of NFFlatten.flatten: time 0.004472/0.03321, allocations: 3.077 MB / 0.8033 GB, free: 11.43 MB / 0.7605 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006489/0.03386, allocations: 230.4 kB / 0.8036 GB, free: 11.18 MB / 0.7605 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003095/0.03696, allocations: 1.497 MB / 0.805 GB, free: 9.68 MB / 0.7605 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002685/0.03964, allocations: 1.532 MB / 0.8065 GB, free: 8.145 MB / 0.7605 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006909/0.04033, allocations: 200 kB / 0.8067 GB, free: 7.949 MB / 0.7605 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001113/0.04145, allocations: 323.7 kB / 0.807 GB, free: 7.633 MB / 0.7605 GB
Notification: Performance of NFScalarize.scalarize: time 0.001068/0.04251, allocations: 0.7283 MB / 0.8077 GB, free: 6.902 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.001639/0.04415, allocations: 0.8066 MB / 0.8085 GB, free: 6.094 MB / 0.7605 GB
Notification: Performance of NFConvertDAE.convert: time 0.005196/0.04935, allocations: 3.817 MB / 0.8123 GB, free: 2.266 MB / 0.7605 GB
Notification: Performance of FrontEnd - DAE generated: time 5.35e-06/0.04935, allocations: 0 / 0.8123 GB, free: 2.266 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 1.493e-06/0.04936, allocations: 0 / 0.8123 GB, free: 2.266 MB / 0.7605 GB
Notification: Performance of Transformations before backend: time 7.92e-05/0.04944, allocations: 0 / 0.8123 GB, free: 2.266 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 112
 * Number of variables: 112
Notification: Performance of Generate backend data structure: time 0.008344/0.05778, allocations: 3.45 MB / 0.8156 GB, free: 14.76 MB / 0.7761 GB
Notification: Performance of prepare preOptimizeDAE: time 5.108e-05/0.05783, allocations: 8.031 kB / 0.8156 GB, free: 14.75 MB / 0.7761 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006254/0.05846, allocations: 295.3 kB / 0.8159 GB, free: 14.46 MB / 0.7761 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004428/0.06288, allocations: 2.019 MB / 0.8179 GB, free: 12.39 MB / 0.7761 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.306e-05/0.06296, allocations: 65.38 kB / 0.8179 GB, free: 12.33 MB / 0.7761 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002353/0.06319, allocations: 91.94 kB / 0.818 GB, free: 12.24 MB / 0.7761 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001323/0.06452, allocations: 0.7207 MB / 0.8187 GB, free: 11.52 MB / 0.7761 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.381e-05/0.06453, allocations: 0 / 0.8187 GB, free: 11.52 MB / 0.7761 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.872e-05/0.06459, allocations: 16 kB / 0.8188 GB, free: 11.5 MB / 0.7761 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.444e-05/0.0646, allocations: 12 kB / 0.8188 GB, free: 11.49 MB / 0.7761 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001724/0.06633, allocations: 0.9758 MB / 0.8197 GB, free: 10.51 MB / 0.7761 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.01146/0.07778, allocations: 3.626 MB / 0.8233 GB, free: 6.848 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001752/0.07953, allocations: 0.7384 MB / 0.824 GB, free: 6.098 MB / 0.7761 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007511/0.08029, allocations: 474.4 kB / 0.8244 GB, free: 5.633 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.202e-05/0.08033, allocations: 8.719 kB / 0.8244 GB, free: 5.625 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.811e-05/0.08037, allocations: 38.56 kB / 0.8245 GB, free: 5.578 MB / 0.7761 GB
Notification: Performance of pre-optimization done (n=44): time 2.625e-06/0.08037, allocations: 0 / 0.8245 GB, free: 5.578 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=44): time 0.01102/0.09138, allocations: 3.386 MB / 0.8278 GB, free: 2.176 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.321e-05/0.09144, allocations: 59.36 kB / 0.8278 GB, free: 2.105 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004552/0.09599, allocations: 2.86 MB / 0.8306 GB, free: 15.23 MB / 0.7917 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002626/0.09625, allocations: 53.7 kB / 0.8307 GB, free: 15.17 MB / 0.7917 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0011/0.09735, allocations: 0.8631 MB / 0.8315 GB, free: 14.3 MB / 0.7917 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002121/0.09756, allocations: 170.5 kB / 0.8317 GB, free: 14.13 MB / 0.7917 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006864/0.09825, allocations: 327.5 kB / 0.832 GB, free: 13.81 MB / 0.7917 GB
Notification: Performance of setup shared object (initialization): time 0.0002272/0.09848, allocations: 369.9 kB / 0.8324 GB, free: 13.44 MB / 0.7917 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002234/0.1007, allocations: 1.366 MB / 0.8337 GB, free: 12.07 MB / 0.7917 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002799/0.1035, allocations: 1.85 MB / 0.8355 GB, free: 10.16 MB / 0.7917 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003167/0.1067, allocations: 1.918 MB / 0.8374 GB, free: 8.23 MB / 0.7917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.699e-06/0.1067, allocations: 0 / 0.8374 GB, free: 8.23 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=167) (initialization): time 0.008597/0.1153, allocations: 4.13 MB / 0.8414 GB, free: 4.086 MB / 0.7917 GB
Notification: Performance of prepare postOptimizeDAE: time 2.179e-05/0.1153, allocations: 6.344 kB / 0.8414 GB, free: 4.082 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.167e-06/0.1153, allocations: 0 / 0.8414 GB, free: 4.082 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003943/0.1193, allocations: 1.151 MB / 0.8425 GB, free: 2.926 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001195/0.1204, allocations: 223.7 kB / 0.8427 GB, free: 2.707 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01424/0.1347, allocations: 7.763 MB / 0.8503 GB, free: 10.84 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002055/0.1367, allocations: 258.6 kB / 0.8506 GB, free: 10.58 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002251/0.137, allocations: 43.98 kB / 0.8506 GB, free: 10.54 MB / 0.8073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 2
 * 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 (126):
 * Single equations (assignments): 125
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * 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
   {(11,31,46.3%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.001411/0.1384, allocations: 0.8017 MB / 0.8514 GB, free: 9.727 MB / 0.8073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006124/0.139, allocations: 226.5 kB / 0.8516 GB, free: 9.504 MB / 0.8073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0005107/0.1395, allocations: 262 kB / 0.8519 GB, free: 9.242 MB / 0.8073 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.961e-06/0.1395, allocations: 4 kB / 0.8519 GB, free: 9.238 MB / 0.8073 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.906e-05/0.1395, allocations: 8 kB / 0.8519 GB, free: 9.23 MB / 0.8073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.103e-06/0.1395, allocations: 3.984 kB / 0.8519 GB, free: 9.227 MB / 0.8073 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001504/0.1411, allocations: 0.9734 MB / 0.8528 GB, free: 8.223 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.705e-06/0.1411, allocations: 0 / 0.8528 GB, free: 8.223 MB / 0.8073 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 5.419e-05/0.1411, allocations: 4 kB / 0.8528 GB, free: 8.219 MB / 0.8073 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003716/0.1448, allocations: 1.07 MB / 0.8539 GB, free: 7.145 MB / 0.8073 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.339e-05/0.1449, allocations: 8 kB / 0.8539 GB, free: 7.137 MB / 0.8073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01414/0.159, allocations: 7.731 MB / 0.8614 GB, free: 15.29 MB / 0.823 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.234e-06/0.159, allocations: 0 / 0.8614 GB, free: 15.29 MB / 0.823 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004506/0.1635, allocations: 1.946 MB / 0.8633 GB, free: 13.32 MB / 0.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009904/0.1645, allocations: 374.3 kB / 0.8637 GB, free: 12.95 MB / 0.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003239/0.1648, allocations: 12.05 kB / 0.8637 GB, free: 12.94 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006765/0.1655, allocations: 39.84 kB / 0.8637 GB, free: 12.9 MB / 0.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001745/0.1657, allocations: 39.92 kB / 0.8638 GB, free: 12.86 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.334e-05/0.1657, allocations: 8 kB / 0.8638 GB, free: 12.86 MB / 0.823 GB
Notification: Performance of sorting global known variables: time 0.003516/0.1692, allocations: 1.976 MB / 0.8657 GB, free: 10.87 MB / 0.823 GB
Notification: Performance of sort global known variables: time 1.7e-07/0.1692, allocations: 4 kB / 0.8657 GB, free: 10.87 MB / 0.823 GB
Notification: Performance of remove unused functions: time 0.001986/0.1712, allocations: 0.6246 MB / 0.8663 GB, free: 10.24 MB / 0.823 GB
Notification: Model statistics after passing the back-end for simulation:
 * 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 simulation (3):
 * Single equations (assignments): 2
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * 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
   {(13,29,43.8%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.00048/0.1717, allocations: 170.7 kB / 0.8665 GB, free: 10.08 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.005593/0.1773, allocations: 2.537 MB / 0.869 GB, free: 7.535 MB / 0.823 GB
Notification: Performance of simCode: created event and clocks part: time 3.597e-06/0.1773, allocations: 0 / 0.869 GB, free: 7.535 MB / 0.823 GB
Notification: Performance of simCode: created simulation system equations: time 0.002616/0.1799, allocations: 1.011 MB / 0.87 GB, free: 6.508 MB / 0.823 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002981/0.1829, allocations: 0.6167 MB / 0.8706 GB, free: 5.902 MB / 0.823 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007813/0.1907, allocations: 4.215 MB / 0.8747 GB, free: 1.648 MB / 0.823 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002118/0.1928, allocations: 1.331 MB / 0.876 GB, free: 284 kB / 0.823 GB
Notification: Performance of simCode: alias equations: time 0.001153/0.194, allocations: 313.4 kB / 0.8763 GB, free: 15.96 MB / 0.8386 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004154/0.1944, allocations: 88.5 kB / 0.8764 GB, free: 15.87 MB / 0.8386 GB
Notification: Performance of SimCode: time 9.52e-07/0.1944, allocations: 0 / 0.8764 GB, free: 15.87 MB / 0.8386 GB
Notification: Performance of Templates: time 0.07677/0.2712, allocations: 44.05 MB / 0.9194 GB, free: 4.434 MB / 0.8698 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.makefile [Timeout 300]
(rm -f Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.pipe ; mkfifo Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.pipe ; head -c 1048576 < Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.pipe >> ../files/Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.sim & ./Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_ThermalZones_Detailed_BaseClasses_Examples_InfraredRadiationExchange.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.ThermalZones.Detailed.BaseClasses.Examples.InfraredRadiationExchange.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 8.55549136607442]