/*
 *  The MIT License
 *
 *   Copyright (c) 2015, Mahmoud Ben Hassine (mahmoud@benhassine.fr)
 *
 *   Permission is hereby granted, free of charge, to any person obtaining a copy
 *   of this software and associated documentation files (the "Software"), to deal
 *   in the Software without restriction, including without limitation the rights
 *   to use, copy, modify, merge, publish, distribute, sublicense, and/or sell
 *   copies of the Software, and to permit persons to whom the Software is
 *   furnished to do so, subject to the following conditions:
 *
 *   The above copyright notice and this permission notice shall be included in
 *   all copies or substantial portions of the Software.
 *
 *   THE SOFTWARE IS PROVIDED "AS IS", WITHOUT WARRANTY OF ANY KIND, EXPRESS OR
 *   IMPLIED, INCLUDING BUT NOT LIMITED TO THE WARRANTIES OF MERCHANTABILITY,
 *   FITNESS FOR A PARTICULAR PURPOSE AND NONINFRINGEMENT. IN NO EVENT SHALL THE
 *   AUTHORS OR COPYRIGHT HOLDERS BE LIABLE FOR ANY CLAIM, DAMAGES OR OTHER
 *   LIABILITY, WHETHER IN AN ACTION OF CONTRACT, TORT OR OTHERWISE, ARISING FROM,
 *   OUT OF OR IN CONNECTION WITH THE SOFTWARE OR THE USE OR OTHER DEALINGS IN
 *   THE SOFTWARE.
 */

package org.easybatch.core.listener;

import org.easybatch.core.record.Record;

import java.util.logging.Level;
import java.util.logging.Logger;

/**
 * Pipeline listener that calculates each record processing time.
 *
 * @author Mahmoud Ben Hassine (mahmoud@benhassine.fr)
 */
public class RecordProcessingTimeListener implements PipelineListener {

    private static final Logger LOGGER = Logger.getLogger(RecordProcessingTimeListener.class.getName());

    private long recordNumber;

    private long startTime;

    @Override
    public Object beforeRecordProcessing(Object inputRecord) {
        Record record = (Record) inputRecord;
        recordNumber = record.getHeader().getNumber();
        startTime = System.currentTimeMillis();
        return inputRecord;
    }

    @Override
    public void afterRecordProcessing(Object inputRecord, Object outputRecord) {
        logProcessingTime();
    }

    @Override
    public void onRecordProcessingException(Object record, Throwable throwable) {
        logProcessingTime();
    }

    private void logProcessingTime() {
        long elapsedTime = System.currentTimeMillis() - startTime;
        LOGGER.log(Level.INFO, "Record N° {0} processing time = {1}ms", new Object[]{recordNumber, elapsedTime});
    }
}

implement feature #133 : add RecordProcessingTimeListener