Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001354/0.001354, allocations: 111.3 kB / 17.61 MB, free: 4.684 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001365/0.001365, allocations: 185.9 kB / 20.78 MB, free: 1.52 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.458/1.458, allocations: 225.6 MB / 249.4 MB, free: 3.16 MB / 190.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.568/2.568, allocations: 443.4 MB / 0.7304 GB, free: 14.04 MB / 0.5762 GB " [Timeout remaining time 177] Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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(Buildings.Fluid.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|pump.m_flow",fileNamePrefix="Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1") translateModel(Buildings.Fluid.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|pump.m_flow",fileNamePrefix="Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1") [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 0.002026/0.002026, allocations: 59.91 kB / 1.059 GB, free: 420 kB / 0.795 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3252/0.3272, allocations: 160.7 MB / 1.216 GB, free: 15.39 MB / 0.9669 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example1v1): time 0.7089/1.036, allocations: 74.07 MB / 1.288 GB, free: 7.879 MB / 0.9981 GB Notification: Performance of NFInst.instExpressions: time 0.03045/1.067, allocations: 18.94 MB / 1.307 GB, free: 376 kB / 0.9981 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.005298/1.072, allocations: 94.31 kB / 1.307 GB, free: 340 kB / 0.9981 GB Notification: Performance of NFTyping.typeComponents: time 0.006762/1.079, allocations: 1.823 MB / 1.309 GB, free: 15.48 MB / 1.014 GB Notification: Performance of NFTyping.typeBindings: time 0.009493/1.088, allocations: 2.593 MB / 1.311 GB, free: 13.96 MB / 1.014 GB Notification: Performance of NFTyping.typeClassSections: time 0.007692/1.096, allocations: 2.185 MB / 1.313 GB, free: 12.83 MB / 1.014 GB Notification: Performance of NFFlatten.flatten: time 0.01869/1.114, allocations: 10.99 MB / 1.324 GB, free: 8.34 MB / 1.014 GB Notification: Performance of NFFlatten.resolveConnections: time 0.009101/1.124, allocations: 4.898 MB / 1.329 GB, free: 6.105 MB / 1.014 GB Notification: Performance of NFEvalConstants.evaluate: time 0.01023/1.134, allocations: 3.384 MB / 1.332 GB, free: 4.629 MB / 1.014 GB Notification: Performance of NFSimplifyModel.simplify: time 0.006728/1.141, allocations: 2.682 MB / 1.335 GB, free: 3.465 MB / 1.014 GB Notification: Performance of NFPackage.collectConstants: time 0.001249/1.142, allocations: 265.9 kB / 1.335 GB, free: 3.465 MB / 1.014 GB Notification: Performance of NFFlatten.collectFunctions: time 0.006046/1.148, allocations: 1.586 MB / 1.337 GB, free: 3.039 MB / 1.014 GB Notification: Performance of NFScalarize.scalarize: time 0.001676/1.15, allocations: 0.9367 MB / 1.338 GB, free: 2.52 MB / 1.014 GB Notification: Performance of NFVerifyModel.verify: time 0.005031/1.155, allocations: 1.963 MB / 1.34 GB, free: 1.332 MB / 1.014 GB Notification: Performance of NFConvertDAE.convert: time 0.01137/1.166, allocations: 5.379 MB / 1.345 GB, free: 15.02 MB / 1.029 GB Notification: Performance of FrontEnd - DAE generated: time 6.382e-06/1.166, allocations: 0 / 1.345 GB, free: 15.02 MB / 1.029 GB Notification: Performance of FrontEnd: time 1.853e-06/1.166, allocations: 0 / 1.345 GB, free: 15.02 MB / 1.029 GB Notification: Performance of Transformations before backend: time 0.0001977/1.166, allocations: 0 / 1.345 GB, free: 15.02 MB / 1.029 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 402 * Number of variables: 402 Notification: Performance of Generate backend data structure: time 0.01243/1.179, allocations: 4.397 MB / 1.349 GB, free: 11.81 MB / 1.029 GB Notification: Performance of prepare preOptimizeDAE: time 6.822e-05/1.179, allocations: 9.281 kB / 1.349 GB, free: 11.81 MB / 1.029 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004067/1.183, allocations: 0.6938 MB / 1.35 GB, free: 11.47 MB / 1.029 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.011/1.194, allocations: 3.843 MB / 1.354 GB, free: 8.953 MB / 1.029 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002014/1.194, allocations: 136.7 kB / 1.354 GB, free: 8.895 MB / 1.029 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005434/1.194, allocations: 185.7 kB / 1.354 GB, free: 8.84 MB / 1.029 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.005153/1.2, allocations: 2.345 MB / 1.356 GB, free: 7.25 MB / 1.029 GB Notification: Performance of preOpt findStateOrder (simulation): time 4.77e-05/1.2, allocations: 11.56 kB / 1.356 GB, free: 7.242 MB / 1.029 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002104/1.2, allocations: 69.09 kB / 1.356 GB, free: 7.191 MB / 1.029 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.906e-05/1.2, allocations: 43.66 kB / 1.356 GB, free: 7.191 MB / 1.029 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004281/1.204, allocations: 1.95 MB / 1.358 GB, free: 6.188 MB / 1.029 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.01954/1.224, allocations: 11.72 MB / 1.37 GB, free: 12.46 MB / 1.045 GB Notification: Performance of preOpt comSubExp (simulation): time 0.003024/1.227, allocations: 1.336 MB / 1.371 GB, free: 11.78 MB / 1.045 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001715/1.228, allocations: 0.9867 MB / 1.372 GB, free: 11.3 MB / 1.045 GB Notification: Performance of preOpt evalFunc (simulation): time 0.008706/1.237, allocations: 4.094 MB / 1.376 GB, free: 7.891 MB / 1.045 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001997/1.239, allocations: 0.893 MB / 1.377 GB, free: 7.348 MB / 1.045 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.003136/1.242, allocations: 485.4 kB / 1.377 GB, free: 7.137 MB / 1.045 GB Notification: Performance of pre-optimization done (n=95): time 5.039e-06/1.242, allocations: 0 / 1.377 GB, free: 7.137 MB / 1.045 GB Notification: Performance of matching and sorting (n=95): time 0.01336/1.256, allocations: 4.522 MB / 1.382 GB, free: 4.637 MB / 1.045 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.89e-05/1.256, allocations: 60.59 kB / 1.382 GB, free: 4.574 MB / 1.045 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006287/1.262, allocations: 3.472 MB / 1.385 GB, free: 1.898 MB / 1.045 GB Notification: Performance of collectPreVariables (initialization): time 0.0005045/1.262, allocations: 69.64 kB / 1.385 GB, free: 1.824 MB / 1.045 GB Notification: Performance of collectInitialEqns (initialization): time 0.001777/1.264, allocations: 1.586 MB / 1.387 GB, free: 232 kB / 1.045 GB Notification: Performance of collectInitialBindings (initialization): time 0.0005549/1.265, allocations: 361.2 kB / 1.387 GB, free: 15.87 MB / 1.061 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.000823/1.266, allocations: 471.6 kB / 1.387 GB, free: 15.4 MB / 1.061 GB Notification: Performance of setup shared object (initialization): time 0.0001262/1.266, allocations: 305.1 kB / 1.388 GB, free: 15.1 MB / 1.061 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001816/1.268, allocations: 0.9659 MB / 1.389 GB, free: 14.13 MB / 1.061 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.002576/1.27, allocations: 1.772 MB / 1.39 GB, free: 12 MB / 1.061 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.004094/1.274, allocations: 2.462 MB / 1.393 GB, free: 9.312 MB / 1.061 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.127e-05/1.274, allocations: 4 kB / 1.393 GB, free: 9.309 MB / 1.061 GB Notification: Performance of matching and sorting (n=250) (initialization): time 0.008257/1.283, allocations: 3.539 MB / 1.396 GB, free: 5.754 MB / 1.061 GB Notification: Performance of prepare postOptimizeDAE: time 7.389e-05/1.283, allocations: 37.7 kB / 1.396 GB, free: 5.711 MB / 1.061 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.603e-05/1.283, allocations: 24.14 kB / 1.396 GB, free: 5.688 MB / 1.061 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002517/1.285, allocations: 0.6918 MB / 1.397 GB, free: 4.988 MB / 1.061 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001634/1.287, allocations: 377 kB / 1.397 GB, free: 4.617 MB / 1.061 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002231/1.289, allocations: 1.902 MB / 1.399 GB, free: 2.664 MB / 1.061 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003327/1.292, allocations: 124.2 kB / 1.399 GB, free: 2.543 MB / 1.061 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002641/1.293, allocations: 104 kB / 1.399 GB, free: 2.441 MB / 1.061 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003583/1.296, allocations: 1.683 MB / 1.401 GB, free: 0.7539 MB / 1.061 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002434/1.299, allocations: 1.735 MB / 1.403 GB, free: 14.65 MB / 1.076 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003903/1.303, allocations: 2.405 MB / 1.405 GB, free: 12.02 MB / 1.076 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.109e-05/1.303, allocations: 4 kB / 1.405 GB, free: 12.02 MB / 1.076 GB Notification: Performance of matching and sorting (n=250) (initialization_lambda0): time 0.006997/1.31, allocations: 3.414 MB / 1.409 GB, free: 8.559 MB / 1.076 GB Notification: Performance of prepare postOptimizeDAE: time 5.995e-05/1.31, allocations: 45.69 kB / 1.409 GB, free: 8.508 MB / 1.076 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.369e-05/1.31, allocations: 16 kB / 1.409 GB, free: 8.492 MB / 1.076 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0009913/1.311, allocations: 477.6 kB / 1.409 GB, free: 8.02 MB / 1.076 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001542/1.312, allocations: 361.3 kB / 1.409 GB, free: 7.668 MB / 1.076 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00823/1.32, allocations: 6.349 MB / 1.416 GB, free: 1.031 MB / 1.076 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003665/1.324, allocations: 144.9 kB / 1.416 GB, free: 0.8906 MB / 1.076 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004423/1.324, allocations: 95.94 kB / 1.416 GB, free: 0.7969 MB / 1.076 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 70 * Number of states: 0 () * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,from_dp.y,nRes.y,allowFlowReversal.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (170): * Single equations (assignments): 165 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 1 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,40), (2,5)} Notification: Performance of prepare postOptimizeDAE: time 0.0006909/1.325, allocations: 299.7 kB / 1.416 GB, free: 0.5 MB / 1.076 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001284/1.326, allocations: 345.7 kB / 1.416 GB, free: 164 kB / 1.076 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006763/1.333, allocations: 2.626 MB / 1.419 GB, free: 13.51 MB / 1.092 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.965e-05/1.333, allocations: 15.94 kB / 1.419 GB, free: 13.49 MB / 1.092 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.965e-06/1.333, allocations: 4 kB / 1.419 GB, free: 13.49 MB / 1.092 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004117/1.337, allocations: 2.172 MB / 1.421 GB, free: 11.24 MB / 1.092 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0129/1.35, allocations: 4.808 MB / 1.426 GB, free: 6.355 MB / 1.092 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.538e-06/1.35, allocations: 0 / 1.426 GB, free: 6.355 MB / 1.092 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001015/1.351, allocations: 181.5 kB / 1.426 GB, free: 6.176 MB / 1.092 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.001144/1.352, allocations: 473.2 kB / 1.426 GB, free: 5.707 MB / 1.092 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001194/1.353, allocations: 39.97 kB / 1.426 GB, free: 5.668 MB / 1.092 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001926/1.355, allocations: 1.842 MB / 1.428 GB, free: 3.773 MB / 1.092 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.615e-06/1.355, allocations: 0 / 1.428 GB, free: 3.773 MB / 1.092 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00685/1.361, allocations: 3.4 MB / 1.432 GB, free: 348 kB / 1.092 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001966/1.363, allocations: 0.5495 MB / 1.432 GB, free: 15.77 MB / 1.107 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005607/1.364, allocations: 27.98 kB / 1.432 GB, free: 15.74 MB / 1.107 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001295/1.365, allocations: 79.89 kB / 1.432 GB, free: 15.66 MB / 1.107 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002045/1.365, allocations: 76.89 kB / 1.432 GB, free: 15.59 MB / 1.107 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000116/1.365, allocations: 47.97 kB / 1.432 GB, free: 15.54 MB / 1.107 GB Notification: Performance of sorting global known variables: time 0.003954/1.369, allocations: 2.351 MB / 1.435 GB, free: 13.18 MB / 1.107 GB Notification: Performance of sort global known variables: time 1.4e-07/1.369, allocations: 4 kB / 1.435 GB, free: 13.17 MB / 1.107 GB Notification: Performance of remove unused functions: time 0.005131/1.375, allocations: 1.529 MB / 1.436 GB, free: 11.64 MB / 1.107 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 2 (pump.vol.dynBal.U,hea.outCon.T) * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count) * Number of discrete states: 1 (pulse.count) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (79): * Single equations (assignments): 71 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 4 * When equations: 2 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(2,5), (1,40)} Notification: Performance of Backend phase and start with SimCode phase: time 0.00168/1.376, allocations: 0.6044 MB / 1.437 GB, free: 11.04 MB / 1.107 GB Notification: Performance of simCode: created initialization part: time 0.007506/1.384, allocations: 3.766 MB / 1.44 GB, free: 7.227 MB / 1.107 GB Notification: Performance of simCode: created event and clocks part: time 6.211e-06/1.384, allocations: 0 / 1.44 GB, free: 7.227 MB / 1.107 GB Notification: Performance of simCode: created simulation system equations: time 0.001743/1.386, allocations: 0.7772 MB / 1.441 GB, free: 6.449 MB / 1.107 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008194/1.394, allocations: 1.466 MB / 1.443 GB, free: 5.008 MB / 1.107 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01563/1.409, allocations: 6.147 MB / 1.449 GB, free: 14.82 MB / 1.123 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003282/1.413, allocations: 2.245 MB / 1.451 GB, free: 12.55 MB / 1.123 GB Notification: Performance of simCode: alias equations: time 0.0041/1.417, allocations: 0.858 MB / 1.452 GB, free: 11.68 MB / 1.123 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001014/1.418, allocations: 251.3 kB / 1.452 GB, free: 11.44 MB / 1.123 GB Notification: Performance of SimCode: time 1.643e-06/1.418, allocations: 0 / 1.452 GB, free: 11.44 MB / 1.123 GB Notification: Performance of Templates: time 0.1153/1.533, allocations: 63.51 MB / 1.514 GB, free: 12.77 MB / 1.186 GB " [Timeout remaining time 298] make -j1 -f Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.makefile [Timeout 300] (rm -f Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.pipe ; mkfifo Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.pipe ; head -c 1048576 < Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.pipe >> ../files/Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.sim & ./Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1 -abortSlowSimulation -alarm=400 -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.pipe 2>&1) [Timeout 400] diffSimulationResults("Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Fluid_Examples_Performance_Example1v1.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Fluid.Examples.Performance.Example1v1.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: 11.165641150437295]