关于laravel计算程序执行时间的优雅写法

计算程序耗时,之前很麻烦,会入侵到业务代码,后来考虑到写到中间件中,还遇到了一些问题
中间件会根据定义顺序依次入栈,先执行前置操作。
然后执行控制器的构造函数,业务代码。
后置中间件会依次出栈,顺序与定义顺序相反。
最后会执行控制器的析构函数。

最后觉得写到控制器的父类析构函数中是一个不错的选择

laravel本身也在入口文件中提供了一个 LARAVEL_START的常量记录了开始时间

我们只需要在父类析构函数中这样写即可

本作品采用《CC 协议》,转载必须注明作者和本文链接
《L01 基础入门》
我们将带你从零开发一个项目并部署到线上,本课程教授 Web 开发中专业、实用的技能,如 Git 工作流、Laravel Mix 前端工作流等。
《G01 Go 实战入门》
从零开始带你一步步开发一个 Go 博客项目,让你在最短的时间内学会使用 Go 进行编码。项目结构很大程度上参考了 Laravel。
讨论数量: 8
  1. 要怎样写
  2. 你为什么不使用后置中间件记录,具体可查看文档 AfterMiddleware
  3. 中间件的洋葱模型也足够你记录一个时间了。
1年前 评论
JaguarJack 1年前
三餐四季 (楼主) 1年前

都可以 我们是在terminating 里面

1年前 评论
三餐四季 (楼主) 1年前
sanders

我们是写在 AppServiceProvider 里面,注册个挂钟实例,主要就看 API 或者 队里里面执行各个位置的时间。

        $this->app->instance('wallTime', new WallTime());
        Queue::before(function (JobProcessing $event) {
            $this->app->instance('wallTime', new WallTime());
        });

缺点嘛,就是没法去统计服务注册的耗时(如果加载的提供者注册方法写的不局气,还是有很大风险的)。

WallTime逻辑比较简单就是打日志:

<?php

namespace App\Services;

use Illuminate\Support\Str;

class WallTime
{
    /**
     * 默认标记长度
     */
    const MARK_LENGTH_DEFAULT       = 6;

    /**
     * 慢日志默认超时时间
     */
    const SLOW_LOG_TIMEOUT_DEFAULT  = 3;

    /**
     * @var float 挂钟时间
     */
    protected $wallTime;

    /**
     * @var string 标识
     */
    protected $mark;

    /**
     * @var array 日志数据
     */
    protected $log  = [];

    /**
     * 构造函数
     *
     * @param int $markLength
     */
    public function __construct(int $markLength = self::MARK_LENGTH_DEFAULT)
    {
        $this->wallTime = microtime(true);
        $this->mark     = Str::random($markLength);
    }

    /**
     * 经过时间
     *
     * @return float
     */
    public function delay(): float
    {
       return   round(microtime(true)-$this->wallTime,2);
    }

    /**
     * 获取标识
     *
     * @return string
     */
    public function mark(): string
    {
        return $this->mark;
    }

    /**
     * 记录日志
     *
     * @param array $data
     */
    public function info(array $data = [])
    {
        info($this->message(), $data);
    }

    /**
     * 慢日志
     *
     * @param array $data
     * @param int $timeout
     */
    public function slow(array $data = [], int $timeout = self::SLOW_LOG_TIMEOUT_DEFAULT)
    {
        $this->log[]    = [
            $this->message(),
            $data,
        ];

        if ($this->delay() > $timeout) {
            foreach ($this->log as $item) {
                info($item[0],$item[1]);
            }
            $this->log  = [];
        }
    }

    /**
     * 消息体
     *
     * @return string
     */
    protected function message(): string
    {
        $delay  = $this->delay();

        return  "$this->mark\t$delay";
    }
}

另外,日志我们也做了跟踪策略,如果想探讨一下,我之后再贴出来。

1年前 评论

如果是要在析构函数中记录执行日志的话,需要注意的是在析构函数中操作文件需要使用绝对路径,因为析构函数在脚本关闭时调用,此时的工作目录和在SAPI时是不一样。

1年前 评论

代码地址

public function recordRequest(RequestHandled $event)
    {
        if (! Telescope::isRecording() ||
            $this->shouldIgnoreHttpMethod($event) ||
            $this->shouldIgnoreStatusCode($event)) {
            return;
        }

        $startTime = defined('LARAVEL_START') ? LARAVEL_START : $event->request->server('REQUEST_TIME_FLOAT');

        Telescope::recordRequest(IncomingEntry::make([
            'ip_address' => $event->request->ip(),
            'uri' => str_replace($event->request->root(), '', $event->request->fullUrl()) ?: '/',
            'method' => $event->request->method(),
            'controller_action' => optional($event->request->route())->getActionName(),
            'middleware' => array_values(optional($event->request->route())->gatherMiddleware() ?? []),
            'headers' => $this->headers($event->request->headers->all()),
            'payload' => $this->payload($this->input($event->request)),
            'session' => $this->payload($this->sessionVariables($event->request)),
            'response_status' => $event->response->getStatusCode(),
            'response' => $this->response($event->response),
            'duration' => $startTime ? floor((microtime(true) - $startTime) * 1000) : null,
            'memory' => round(memory_get_peak_usage(true) / 1024 / 1024, 1),
        ]));
    }

这种东西参考现成的写法就可以了

1年前 评论

讨论应以学习和精进为目的。请勿发布不友善或者负能量的内容,与人为善,比聪明更重要!