Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.FMI.Conversion.Validation.AirToOutletFlowReversal.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.FMI.Conversion.Validation.AirToOutletFlowReversal,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.FMI.Conversion.Validation.AirToOutletFlowReversal")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002636/0.00264, allocations: 355.5 kB / 16.59 MB, free: 5.566 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.701/1.701, allocations: 165.8 MB / 183.1 MB, free: 5.379 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.525/4.525, allocations: 410.7 MB / 0.6001 GB, free: 15.15 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001781/0.001781, allocations: 196.4 kB / 0.6668 GB, free: 6.918 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005012/0.000502, allocations: 12 kB / 0.7429 GB, free: 8.945 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4321/0.4326, allocations: 67.44 MB / 0.8087 GB, free: 28.77 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.FMI.Conversion.Validation.AirToOutletFlowReversal): time 0.8416/1.274, allocations: 223.8 MB / 1.027 GB, free: 6.352 MB / 490.7 MB
Notification: Performance of NFInst.instExpressions: time 0.06362/1.338, allocations: 20.54 MB / 1.047 GB, free: 3.391 MB / 0.4948 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002416/1.34, allocations: 47.69 kB / 1.047 GB, free: 3.344 MB / 0.4948 GB
Notification: Performance of NFTyping.typeComponents: time 0.003494/1.344, allocations: 0.5318 MB / 1.048 GB, free: 2.809 MB / 0.4948 GB
Notification: Performance of NFTyping.typeBindings: time 0.008041/1.352, allocations: 1.599 MB / 1.049 GB, free: 1.203 MB / 0.4948 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008883/1.361, allocations: 1.433 MB / 1.051 GB, free: 15.78 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.009566/1.371, allocations: 3.136 MB / 1.054 GB, free: 12.63 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003957/1.375, allocations: 0.9078 MB / 1.055 GB, free: 11.71 MB / 0.5105 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004852/1.38, allocations: 0.9645 MB / 1.056 GB, free: 10.74 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00304/1.383, allocations: 0.8014 MB / 1.057 GB, free: 9.938 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004916/1.383, allocations: 36 kB / 1.057 GB, free: 9.902 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004726/1.388, allocations: 0.74 MB / 1.057 GB, free: 9.16 MB / 0.5105 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009797/1.389, allocations: 279 kB / 1.058 GB, free: 8.887 MB / 0.5105 GB
Notification: Performance of NFVerifyModel.verify: time 0.0009923/1.39, allocations: 269.1 kB / 1.058 GB, free: 8.617 MB / 0.5105 GB
Notification: Performance of NFConvertDAE.convert: time 0.004781/1.395, allocations: 1.508 MB / 1.059 GB, free: 7.105 MB / 0.5105 GB
Notification: Performance of FrontEnd - DAE generated: time 8.286e-06/1.395, allocations: 0 / 1.059 GB, free: 7.105 MB / 0.5105 GB
Notification: Performance of FrontEnd: time 3.267e-06/1.395, allocations: 0 / 1.059 GB, free: 7.105 MB / 0.5105 GB
Notification: Performance of Transformations before backend: time 5.759e-05/1.395, allocations: 0 / 1.059 GB, free: 7.105 MB / 0.5105 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 224
 * Number of variables: 224
Notification: Performance of Generate backend data structure: time 0.004304/1.399, allocations: 1.223 MB / 1.061 GB, free: 5.832 MB / 0.5105 GB
Notification: Performance of prepare preOptimizeDAE: time 7.15e-05/1.399, allocations: 12.03 kB / 1.061 GB, free: 5.82 MB / 0.5105 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002669/1.402, allocations: 226.4 kB / 1.061 GB, free: 5.598 MB / 0.5105 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003388/1.406, allocations: 0.8186 MB / 1.062 GB, free: 4.734 MB / 0.5105 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004067/1.406, allocations: 188.8 kB / 1.062 GB, free: 4.527 MB / 0.5105 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003826/1.406, allocations: 92 kB / 1.062 GB, free: 4.438 MB / 0.5105 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004367/1.411, allocations: 0.9246 MB / 1.063 GB, free: 3.477 MB / 0.5105 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.932e-05/1.411, allocations: 0 / 1.063 GB, free: 3.477 MB / 0.5105 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000214/1.411, allocations: 39.98 kB / 1.063 GB, free: 3.438 MB / 0.5105 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.732e-05/1.411, allocations: 24 kB / 1.063 GB, free: 3.414 MB / 0.5105 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003325/1.415, allocations: 0.6246 MB / 1.063 GB, free: 2.793 MB / 0.5105 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.011/1.426, allocations: 4.447 MB / 1.068 GB, free: 13.95 MB / 0.5261 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009011/1.427, allocations: 186.7 kB / 1.068 GB, free: 13.76 MB / 0.5261 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005503/1.427, allocations: 140.8 kB / 1.068 GB, free: 13.62 MB / 0.5261 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001555/1.429, allocations: 1.017 MB / 1.069 GB, free: 12.38 MB / 0.5261 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.066e-05/1.429, allocations: 38.56 kB / 1.069 GB, free: 12.33 MB / 0.5261 GB
Notification: Performance of pre-optimization done (n=24): time 3.597e-06/1.429, allocations: 4 kB / 1.069 GB, free: 12.33 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=24): time 0.001873/1.431, allocations: 469.1 kB / 1.07 GB, free: 11.87 MB / 0.5261 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.311e-05/1.431, allocations: 55.41 kB / 1.07 GB, free: 11.8 MB / 0.5261 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002473/1.433, allocations: 1.098 MB / 1.071 GB, free: 10.69 MB / 0.5261 GB
Notification: Performance of collectPreVariables (initialization): time 9.365e-05/1.434, allocations: 29.7 kB / 1.071 GB, free: 10.65 MB / 0.5261 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006505/1.434, allocations: 0.5117 MB / 1.071 GB, free: 10.14 MB / 0.5261 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000128/1.434, allocations: 94.77 kB / 1.071 GB, free: 10.04 MB / 0.5261 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.281e-05/1.434, allocations: 12 kB / 1.071 GB, free: 10.03 MB / 0.5261 GB
Notification: Performance of setup shared object (initialization): time 0.0001512/1.435, allocations: 322 kB / 1.072 GB, free: 9.711 MB / 0.5261 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004356/1.435, allocations: 120.8 kB / 1.072 GB, free: 9.594 MB / 0.5261 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007267/1.436, allocations: 387.1 kB / 1.072 GB, free: 9.109 MB / 0.5261 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0005408/1.436, allocations: 183.8 kB / 1.072 GB, free: 8.93 MB / 0.5261 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.314e-05/1.436, allocations: 7.953 kB / 1.072 GB, free: 8.922 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=48) (initialization): time 0.001711/1.438, allocations: 0.5313 MB / 1.073 GB, free: 8.383 MB / 0.5261 GB
Notification: Performance of prepare postOptimizeDAE: time 3.777e-05/1.438, allocations: 11.98 kB / 1.073 GB, free: 8.371 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.898e-05/1.438, allocations: 8 kB / 1.073 GB, free: 8.363 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.031e-05/1.438, allocations: 8 kB / 1.073 GB, free: 8.355 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007219/1.439, allocations: 91.84 kB / 1.073 GB, free: 8.266 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.834e-05/1.439, allocations: 15.92 kB / 1.073 GB, free: 8.25 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001604/1.441, allocations: 123.3 kB / 1.073 GB, free: 8.129 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001301/1.441, allocations: 27.98 kB / 1.073 GB, free: 8.102 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 28
 * 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 (48):
 * Single equations (assignments): 48
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0006931/1.442, allocations: 289.6 kB / 1.073 GB, free: 7.809 MB / 0.5261 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002805/1.442, allocations: 102.7 kB / 1.073 GB, free: 7.707 MB / 0.5261 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001189/1.443, allocations: 434.5 kB / 1.074 GB, free: 7.273 MB / 0.5261 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.201e-05/1.443, allocations: 3.984 kB / 1.074 GB, free: 7.27 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.77e-06/1.443, allocations: 3.938 kB / 1.074 GB, free: 7.266 MB / 0.5261 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006439/1.444, allocations: 239.6 kB / 1.074 GB, free: 7.012 MB / 0.5261 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002023/1.444, allocations: 4 kB / 1.074 GB, free: 7.008 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007847/1.445, allocations: 27.89 kB / 1.074 GB, free: 6.98 MB / 0.5261 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.124e-05/1.445, allocations: 15.97 kB / 1.074 GB, free: 6.965 MB / 0.5261 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0009381/1.446, allocations: 360.7 kB / 1.074 GB, free: 6.605 MB / 0.5261 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001059/1.447, allocations: 0.5177 MB / 1.075 GB, free: 6.07 MB / 0.5261 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0003106/1.447, allocations: 111.9 kB / 1.075 GB, free: 5.961 MB / 0.5261 GB
Notification: Performance of sorting global known variables: time 0.00179/1.449, allocations: 0.7664 MB / 1.076 GB, free: 5.188 MB / 0.5261 GB
Notification: Performance of Backend: time 1.413e-06/1.449, allocations: 0 / 1.076 GB, free: 5.188 MB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.002803/1.452, allocations: 0.6056 MB / 1.076 GB, free: 4.586 MB / 0.5261 GB
Notification: Performance of SimCode: time 0.007704/1.46, allocations: 2.533 MB / 1.079 GB, free: 2.012 MB / 0.5261 GB
Notification: Performance of Templates: time 0.06093/1.521, allocations: 18.83 MB / 1.097 GB, free: 15.39 MB / 0.5573 GB