Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.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.3.2/package.mo", uses=false)
Using package AixLib with version 1.3.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/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.Validation.ThreeRoomsContamDiscretizedDoor,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor")
translateModel(AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001056/0.001056, allocations: 107.9 kB / 16.41 MB, free: 6.465 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.001101/0.001101, allocations: 192.3 kB / 17.35 MB, free: 5.711 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.269/1.269, allocations: 222.9 MB / 241 MB, free: 15.1 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.05614/0.05614, allocations: 12.05 MB / 303.3 MB, free: 3.102 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.000489/0.000489, allocations: 31.94 kB / 356.3 MB, free: 13.97 MB / 302.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/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.3.2/package.mo): time 1.443/1.443, allocations: 268.2 MB / 0.6617 GB, free: 2.609 MB / 478.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002064/0.002064, allocations: 115.8 kB / 0.888 GB, free: 4.512 MB / 0.6544 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4744/0.4765, allocations: 108.4 MB / 0.9938 GB, free: 11.98 MB / 0.6857 GB
Notification: Performance of NFInst.instantiate(AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor): time 0.759/1.235, allocations: 299.1 MB / 1.286 GB, free: 16.48 MB / 0.9513 GB
Notification: Performance of NFInst.instExpressions: time 0.01895/1.254, allocations: 15.29 MB / 1.301 GB, free: 16.45 MB / 0.9513 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002861/1.257, allocations: 73.25 kB / 1.301 GB, free: 16.45 MB / 0.9513 GB
Notification: Performance of NFTyping.typeComponents: time 0.003915/1.261, allocations: 1.818 MB / 1.303 GB, free: 16.43 MB / 0.9513 GB
Notification: Performance of NFTyping.typeBindings: time 0.01302/1.274, allocations: 6.085 MB / 1.309 GB, free: 16.2 MB / 0.9513 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006957/1.281, allocations: 2.859 MB / 1.311 GB, free: 16.12 MB / 0.9513 GB
Notification: Performance of NFFlatten.flatten: time 0.009999/1.291, allocations: 7.123 MB / 1.318 GB, free: 16.11 MB / 0.9513 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004636/1.296, allocations: 2.719 MB / 1.321 GB, free: 15.84 MB / 0.9513 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006073/1.302, allocations: 2.689 MB / 1.324 GB, free: 15.84 MB / 0.9513 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005179/1.307, allocations: 2.609 MB / 1.326 GB, free: 15.84 MB / 0.9513 GB
Notification: Performance of NFPackage.collectConstants: time 0.001387/1.309, allocations: 342.6 kB / 1.327 GB, free: 15.84 MB / 0.9513 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01181/1.321, allocations: 5.779 MB / 1.332 GB, free: 15.78 MB / 0.9513 GB
Notification: Performance of NFScalarize.scalarize: time 0.002655/1.323, allocations: 1.516 MB / 1.334 GB, free: 15.78 MB / 0.9513 GB
Notification: Performance of NFVerifyModel.verify: time 0.004518/1.328, allocations: 1.923 MB / 1.336 GB, free: 15.57 MB / 0.9513 GB
Notification: Performance of NFConvertDAE.convert: time 0.01367/1.341, allocations: 6.884 MB / 1.342 GB, free: 14.79 MB / 0.9513 GB
Notification: Performance of FrontEnd - DAE generated: time 4.698e-06/1.341, allocations: 1 kB / 1.342 GB, free: 14.79 MB / 0.9513 GB
Notification: Performance of FrontEnd: time 1.583e-06/1.341, allocations: 0 / 1.342 GB, free: 14.79 MB / 0.9513 GB
Notification: Performance of Transformations before backend: time 0.000168/1.342, allocations: 1 kB / 1.342 GB, free: 14.79 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: 726
 * Number of variables: 726
Notification: Performance of Generate backend data structure: time 0.01139/1.353, allocations: 4.268 MB / 1.346 GB, free: 13.03 MB / 0.9513 GB
Notification: Performance of prepare preOptimizeDAE: time 3.813e-05/1.353, allocations: 8.969 kB / 1.346 GB, free: 13.03 MB / 0.9513 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005439/1.359, allocations: 0.8633 MB / 1.347 GB, free: 12.84 MB / 0.9513 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003031/1.362, allocations: 1.875 MB / 1.349 GB, free: 12.32 MB / 0.9513 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001101/1.362, allocations: 215.1 kB / 1.349 GB, free: 12.31 MB / 0.9513 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003862/1.362, allocations: 284 kB / 1.35 GB, free: 12.3 MB / 0.9513 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005398/1.368, allocations: 3.63 MB / 1.353 GB, free: 12.01 MB / 0.9513 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.029e-05/1.368, allocations: 5.875 kB / 1.353 GB, free: 12.01 MB / 0.9513 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002438/1.368, allocations: 112.5 kB / 1.353 GB, free: 12.01 MB / 0.9513 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001197/1.368, allocations: 156.4 kB / 1.353 GB, free: 12 MB / 0.9513 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005356/1.373, allocations: 3.718 MB / 1.357 GB, free: 11.96 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.01375/1.387, allocations: 13.26 MB / 1.37 GB, free: 5.043 MB / 0.9513 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003686/1.391, allocations: 3.221 MB / 1.373 GB, free: 4.578 MB / 0.9513 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002174/1.393, allocations: 1.78 MB / 1.375 GB, free: 4.328 MB / 0.9513 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001211/1.394, allocations: 1.585 MB / 1.376 GB, free: 2.574 MB / 0.9513 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.762e-05/1.394, allocations: 69.28 kB / 1.376 GB, free: 2.527 MB / 0.9513 GB
Notification: Performance of pre-optimization done (n=285): time 4.578e-06/1.394, allocations: 0 / 1.376 GB, free: 2.527 MB / 0.9513 GB
Notification: Performance of matching and sorting (n=285): time 0.006016/1.4, allocations: 4.051 MB / 1.38 GB, free: 1.816 MB / 0.9513 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.218e-05/1.4, allocations: 84.42 kB / 1.38 GB, free: 1.746 MB / 0.9513 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001699/1.402, allocations: 1.425 MB / 1.382 GB, free: 1.363 MB / 0.9513 GB
Notification: Performance of collectPreVariables (initialization): time 0.00018/1.402, allocations: 81.62 kB / 1.382 GB, free: 1.328 MB / 0.9513 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005003/1.403, allocations: 1.025 MB / 1.383 GB, free: 0.8125 MB / 0.9513 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006207/1.403, allocations: 1.014 MB / 1.384 GB, free: 56 kB / 0.9513 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000608/1.404, allocations: 407.2 kB / 1.384 GB, free: 16 MB / 0.9669 GB
Notification: Performance of setup shared object (initialization): time 9.953e-05/1.404, allocations: 307.4 kB / 1.385 GB, free: 15.7 MB / 0.9669 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00163/1.406, allocations: 1.135 MB / 1.386 GB, free: 15.39 MB / 0.9669 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001973/1.408, allocations: 1.404 MB / 1.387 GB, free: 14.58 MB / 0.9669 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003872/1.412, allocations: 2.72 MB / 1.39 GB, free: 12.8 MB / 0.9669 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.231e-06/1.412, allocations: 0 / 1.39 GB, free: 12.8 MB / 0.9669 GB
Notification: Performance of matching and sorting (n=312) (initialization): time 0.004974/1.417, allocations: 3.064 MB / 1.393 GB, free: 9.707 MB / 0.9669 GB
Notification: Performance of prepare postOptimizeDAE: time 2.252e-05/1.417, allocations: 9.719 kB / 1.393 GB, free: 9.699 MB / 0.9669 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.041e-05/1.417, allocations: 2.531 kB / 1.393 GB, free: 9.699 MB / 0.9669 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.633e-05/1.417, allocations: 19.98 kB / 1.393 GB, free: 9.68 MB / 0.9669 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002265/1.419, allocations: 0.5145 MB / 1.393 GB, free: 9.195 MB / 0.9669 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.445e-05/1.419, allocations: 16 kB / 1.393 GB, free: 9.18 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001966/1.421, allocations: 202.4 kB / 1.394 GB, free: 8.98 MB / 0.9669 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001772/1.421, allocations: 83.98 kB / 1.394 GB, free: 8.898 MB / 0.9669 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 (312):
 * Single equations (assignments): 312
 * 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.001283/1.422, allocations: 0.6875 MB / 1.394 GB, free: 8.23 MB / 0.9669 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004044/1.423, allocations: 250.5 kB / 1.394 GB, free: 7.984 MB / 0.9669 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00535/1.428, allocations: 3.194 MB / 1.398 GB, free: 4.738 MB / 0.9669 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004081/1.432, allocations: 2.65 MB / 1.4 GB, free: 2.039 MB / 0.9669 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.291e-06/1.432, allocations: 0 / 1.4 GB, free: 2.039 MB / 0.9669 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001252/1.434, allocations: 0.6315 MB / 1.401 GB, free: 1.387 MB / 0.9669 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000351/1.434, allocations: 55.98 kB / 1.401 GB, free: 1.332 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001502/1.435, allocations: 66.2 kB / 1.401 GB, free: 1.27 MB / 0.9669 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003464/1.436, allocations: 170 kB / 1.401 GB, free: 1.102 MB / 0.9669 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006028/1.442, allocations: 3.238 MB / 1.404 GB, free: 13.86 MB / 0.9825 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.007266/1.449, allocations: 5.153 MB / 1.409 GB, free: 8.629 MB / 0.9825 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001926/1.451, allocations: 1.508 MB / 1.411 GB, free: 7.109 MB / 0.9825 GB
Notification: Performance of sorting global known variables: time 0.001358/1.452, allocations: 0.993 MB / 1.412 GB, free: 6.121 MB / 0.9825 GB
Notification: Performance of Backend: time 4.01e-07/1.452, allocations: 0 / 1.412 GB, free: 6.121 MB / 0.9825 GB
Notification: Performance of simCode: created initialization part: time 0.006204/1.459, allocations: 2.955 MB / 1.415 GB, free: 3.312 MB / 0.9825 GB
Notification: Performance of SimCode: time 0.00978/1.468, allocations: 6.488 MB / 1.421 GB, free: 12.83 MB / 0.9982 GB
Notification: Performance of Templates: time 0.09352/1.562, allocations: 65.91 MB / 1.485 GB, free: 11.59 MB / 1.061 GB
make -j1 -f AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.makefile
(rm -f AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.pipe ; mkfifo AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.pipe ; head -c 1048576 < AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.pipe >> ../files/AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.sim & ./AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Airflow.Multizone.Validation.ThreeRoomsContamDiscretizedDoor.pipe 2>&1)