Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.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/Modelica_DeviceDrivers 2.1.1-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/package.mo", uses=false)
Using package AixLib with version 1.4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/package.mo)
Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo)
Using package Modelica_DeviceDrivers with version 2.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-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: translateModel(AixLib.Airflow.Multizone.Examples.ClosedDoors,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors")
translateModel(AixLib.Airflow.Multizone.Examples.ClosedDoors,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00144/0.00144, allocations: 115.2 kB / 16.42 MB, free: 6.5 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.001638/0.001638, allocations: 183.9 kB / 17.35 MB, free: 5.762 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.319/1.319, allocations: 222.9 MB / 241.1 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/package.mo): time 0.05819/0.05819, allocations: 12.04 MB / 303.3 MB, free: 3.109 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.0005112/0.0005112, allocations: 31.92 kB / 356.3 MB, free: 13.97 MB / 302.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:6228:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:6853:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:8435:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:9369:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:11505:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:12875:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/ThermalZones/HighOrder/Components/Examples/DryAir/DryAir_test.mo:71:18-71:405:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/ThermalZones/HighOrder/Components/DryAir/InfiltrationRate_DIN12831.mo:20:192-20:2066:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/ThermalZones/HighOrder/Components/DryAir/InfiltrationRate_DIN12831.mo:20:192-20:4252:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_N_E_S_W_RoofN_Roof_S.mo:5:35-5:362:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_N_E_S_W_Hor.mo:5:35-5:320:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_NE_SE_SW_NW_Hor.mo:5:35-5:324:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/CHP/CHPDataSimple/CHP_XRGI_9kWel.mo:25:34-25:588:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/CHP/CHPDataSimple/CHP_XRGI_9kWel.mo:25:34-25:3852:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/DataBase/CHP/CHPDataSimple/CHP_Cleanergy_C9G.mo:36:34-36:594:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/BoundaryConditions/InternalGains/Examples/InternalGains/Machines.mo:31:20-31:400:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/BoundaryConditions/InternalGains/Examples/InternalGains/Lights.mo:27:20-27:398:writable] Warning: Lexer treating \ as \\, since \
 is not a valid Modelica escape sequence.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/package.mo): time 1.92/1.92, allocations: 272.3 MB / 0.6657 GB, free: 18.43 MB / 478.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002102/0.002102, allocations: 111.8 kB / 0.8935 GB, free: 15.16 MB / 0.67 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4465/0.4486, allocations: 109.1 MB / 1 GB, free: 8.266 MB / 0.6857 GB
Notification: Performance of NFInst.instantiate(AixLib.Airflow.Multizone.Examples.ClosedDoors): time 0.2081/0.6568, allocations: 218.5 MB / 1.213 GB, free: 5.281 MB / 0.8888 GB
Notification: Performance of NFInst.instExpressions: time 0.02409/0.6809, allocations: 20.41 MB / 1.233 GB, free: 0.8125 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001564/0.6825, allocations: 59.69 kB / 1.233 GB, free: 0.7539 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.002504/0.6851, allocations: 1.247 MB / 1.235 GB, free: 15.5 MB / 0.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.008306/0.6934, allocations: 4.077 MB / 1.239 GB, free: 11.41 MB / 0.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003271/0.6967, allocations: 1.544 MB / 1.24 GB, free: 9.867 MB / 0.92 GB
Notification: Performance of NFFlatten.flatten: time 0.006681/0.7034, allocations: 6.955 MB / 1.247 GB, free: 2.887 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002605/0.706, allocations: 2.372 MB / 1.249 GB, free: 476 kB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003079/0.7091, allocations: 2.399 MB / 1.252 GB, free: 14.05 MB / 0.9357 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003226/0.7123, allocations: 2.455 MB / 1.254 GB, free: 11.6 MB / 0.9357 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005055/0.7128, allocations: 344 kB / 1.254 GB, free: 11.27 MB / 0.9357 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005906/0.7188, allocations: 3.461 MB / 1.258 GB, free: 7.801 MB / 0.9357 GB
Notification: Performance of NFScalarize.scalarize: time 0.001263/0.72, allocations: 1.454 MB / 1.259 GB, free: 6.344 MB / 0.9357 GB
Notification: Performance of NFVerifyModel.verify: time 0.001893/0.7219, allocations: 1.867 MB / 1.261 GB, free: 4.469 MB / 0.9357 GB
Notification: Performance of NFConvertDAE.convert: time 0.006592/0.7285, allocations: 5.768 MB / 1.267 GB, free: 14.69 MB / 0.9513 GB
Notification: Performance of FrontEnd - DAE generated: time 5.24e-06/0.7286, allocations: 0 / 1.267 GB, free: 14.69 MB / 0.9513 GB
Notification: Performance of FrontEnd: time 1.322e-06/0.7286, allocations: 3.938 kB / 1.267 GB, free: 14.68 MB / 0.9513 GB
Notification: Performance of Transformations before backend: time 4.8e-05/0.7286, allocations: 4 kB / 1.267 GB, free: 14.68 MB / 0.9513 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 697
 * Number of variables: 697
Notification: Performance of Generate backend data structure: time 0.008721/0.7373, allocations: 3.941 MB / 1.27 GB, free: 10.68 MB / 0.9513 GB
Notification: Performance of prepare preOptimizeDAE: time 3.872e-05/0.7374, allocations: 8.031 kB / 1.27 GB, free: 10.67 MB / 0.9513 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00488/0.7423, allocations: 0.8276 MB / 1.271 GB, free: 9.836 MB / 0.9513 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003635/0.7459, allocations: 1.933 MB / 1.273 GB, free: 7.844 MB / 0.9513 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001305/0.7461, allocations: 201.4 kB / 1.273 GB, free: 7.645 MB / 0.9513 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003866/0.7465, allocations: 275.9 kB / 1.274 GB, free: 7.375 MB / 0.9513 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005045/0.7515, allocations: 3.275 MB / 1.277 GB, free: 4.059 MB / 0.9513 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.683e-05/0.7516, allocations: 4 kB / 1.277 GB, free: 4.055 MB / 0.9513 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000262/0.7519, allocations: 108 kB / 1.277 GB, free: 3.949 MB / 0.9513 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000116/0.752, allocations: 125.4 kB / 1.277 GB, free: 3.824 MB / 0.9513 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3746/1.127, allocations: 4.604 MB / 1.282 GB, free: 266.9 MB / 0.9513 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.01537/1.142, allocations: 10.91 MB / 1.292 GB, free: 260.5 MB / 0.9513 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005413/1.147, allocations: 4.87 MB / 1.297 GB, free: 257.7 MB / 0.9513 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003157/1.151, allocations: 2.536 MB / 1.299 GB, free: 256.4 MB / 0.9513 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008453/1.151, allocations: 0.8597 MB / 1.3 GB, free: 255.5 MB / 0.9513 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.101e-05/1.151, allocations: 79.73 kB / 1.3 GB, free: 255.5 MB / 0.9513 GB
Notification: Performance of pre-optimization done (n=399): time 5.7e-06/1.151, allocations: 0 / 1.3 GB, free: 255.5 MB / 0.9513 GB
Notification: Performance of matching and sorting (n=399): time 0.008661/1.16, allocations: 6.019 MB / 1.306 GB, free: 252.4 MB / 0.9513 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.04e-05/1.16, allocations: 96.2 kB / 1.306 GB, free: 252.3 MB / 0.9513 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001472/1.162, allocations: 1.226 MB / 1.308 GB, free: 251.7 MB / 0.9513 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001836/1.162, allocations: 92.8 kB / 1.308 GB, free: 251.6 MB / 0.9513 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003653/1.162, allocations: 0.8127 MB / 1.308 GB, free: 250.9 MB / 0.9513 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007088/1.163, allocations: 1.333 MB / 1.31 GB, free: 249.7 MB / 0.9513 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007383/1.164, allocations: 0.5555 MB / 1.31 GB, free: 249.4 MB / 0.9513 GB
Notification: Performance of setup shared object (initialization): time 3.149e-05/1.164, allocations: 301.1 kB / 1.311 GB, free: 249.1 MB / 0.9513 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002175/1.166, allocations: 1.599 MB / 1.312 GB, free: 248.3 MB / 0.9513 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002125/1.168, allocations: 1.923 MB / 1.314 GB, free: 247.2 MB / 0.9513 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004605/1.173, allocations: 3.834 MB / 1.318 GB, free: 245.2 MB / 0.9513 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.837e-06/1.173, allocations: 0 / 1.318 GB, free: 245.2 MB / 0.9513 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.005276/1.178, allocations: 4.183 MB / 1.322 GB, free: 243.2 MB / 0.9513 GB
Notification: Performance of prepare postOptimizeDAE: time 2.005e-05/1.178, allocations: 10.91 kB / 1.322 GB, free: 243.2 MB / 0.9513 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.332e-05/1.178, allocations: 3.906 kB / 1.322 GB, free: 243.2 MB / 0.9513 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.73e-05/1.178, allocations: 19.11 kB / 1.322 GB, free: 243.2 MB / 0.9513 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00268/1.181, allocations: 0.6809 MB / 1.323 GB, free: 242.9 MB / 0.9513 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.487e-05/1.181, allocations: 19.94 kB / 1.323 GB, free: 242.9 MB / 0.9513 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002061/1.183, allocations: 245.2 kB / 1.323 GB, free: 242.7 MB / 0.9513 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001839/1.183, allocations: 116 kB / 1.323 GB, free: 242.5 MB / 0.9513 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * 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 (430):
 * Single equations (assignments): 430
 * 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.0009529/1.184, allocations: 0.7225 MB / 1.324 GB, free: 241.8 MB / 0.9513 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003866/1.184, allocations: 245 kB / 1.324 GB, free: 241.6 MB / 0.9513 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006011/1.19, allocations: 4.624 MB / 1.328 GB, free: 236.9 MB / 0.9513 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004664/1.195, allocations: 3.956 MB / 1.332 GB, free: 232.9 MB / 0.9513 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.905e-06/1.195, allocations: 0 / 1.332 GB, free: 232.9 MB / 0.9513 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001276/1.196, allocations: 0.7587 MB / 1.333 GB, free: 232.1 MB / 0.9513 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002999/1.197, allocations: 67.98 kB / 1.333 GB, free: 232.1 MB / 0.9513 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001742/1.198, allocations: 92.38 kB / 1.333 GB, free: 232 MB / 0.9513 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003406/1.199, allocations: 226.8 kB / 1.333 GB, free: 231.8 MB / 0.9513 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006431/1.205, allocations: 4.557 MB / 1.338 GB, free: 227.2 MB / 0.9513 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.007697/1.213, allocations: 7.131 MB / 1.345 GB, free: 220.1 MB / 0.9513 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002067/1.215, allocations: 2.146 MB / 1.347 GB, free: 217.9 MB / 0.9513 GB
Notification: Performance of sorting global known variables: time 0.0009236/1.216, allocations: 0.8606 MB / 1.348 GB, free: 217 MB / 0.9513 GB
Notification: Performance of Backend: time 6.21e-07/1.216, allocations: 0 / 1.348 GB, free: 217 MB / 0.9513 GB
Notification: Performance of simCode: created initialization part: time 0.004913/1.221, allocations: 3.15 MB / 1.351 GB, free: 214.1 MB / 0.9513 GB
Notification: Performance of SimCode: time 0.007048/1.228, allocations: 5.937 MB / 1.357 GB, free: 208.2 MB / 0.9513 GB
Notification: Performance of Templates: time 0.06614/1.294, allocations: 59.25 MB / 1.414 GB, free: 149.4 MB / 0.9513 GB
make -j1 -f AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.makefile
(rm -f AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.pipe ; mkfifo AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.pipe ; head -c 1048576 < AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.pipe >> ../files/AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.sim & ./AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_latest_AixLib.Airflow.Multizone.Examples.ClosedDoors.pipe 2>&1)