isp_mi_stop called after start_isp.sh

[alvaro_tx]

Hi, we are using the ISP in the i.MX8MP with a Sony IMX307.

When we call start_isp.sh and the ISP kernel modules are loaded, right after starting the isp_media_server, there is a "enter isp_mi_stop", where the camera cannot be launched. 

Then after around one minute, the ISP and the camera starts working. It doesn't happen in all modules. Any idea on why is this?

Log:

Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing vvcam-dwe...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing imx8-media-dev...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing imx307...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing ov2775...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing os08a20...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Removing basler-camera-driver-vvcam...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: Loading module imx307 ...
Mar 06 19:26:02 verdin-imx8mp-14773493 start_isp.sh[665]: imx307
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loaded /usr/lib/modules/5.15.77-6.3.0-devel+git.95b4e4bb8a10/extra/sensor/imx307/imx307.ko
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loading module imx8-media-dev ...
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: imx8_media_dev
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loaded /usr/lib/modules/5.15.77-6.3.0-devel+git.95b4e4bb8a10/kernel/drivers/staging/media/imx/imx8-media-dev.ko
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loading module vvcam-dwe ...
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: vvcam_dwe
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loaded /usr/lib/modules/5.15.77-6.3.0-devel+git.95b4e4bb8a10/extra/vvcam-dwe.ko
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loading module vvcam-isp ...
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: vvcam_isp
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: enter viv_isp_init_module
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: enter isp_hw_probe
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: vvcam isp driver registered
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: enter isp_hw_probe
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: vvcam isp driver registered
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loaded /usr/lib/modules/5.15.77-6.3.0-devel+git.95b4e4bb8a10/extra/vvcam-isp.ko
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loading module vvcam-video ...
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: vvcam_video
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Loaded /usr/lib/modules/5.15.77-6.3.0-devel+git.95b4e4bb8a10/extra/video/vvcam-video.ko
Mar 06 19:26:03 verdin-imx8mp-14773493 start_isp.sh[665]: Starting isp_media_server with configuration file CAMERA0
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:26:03 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:26:12 verdin-imx8mp-14773493 systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 06 19:27:13 verdin-imx8mp-14773493 dbus-daemon[663]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.16' (uid=0 pid=868 comm="/usr/sbin/NetworkManager --no-daemon")
Mar 06 19:27:13 verdin-imx8mp-14773493 systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 06 19:27:13 verdin-imx8mp-14773493 dbus-daemon[663]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 06 19:27:13 verdin-imx8mp-14773493 systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 06 19:27:23 verdin-imx8mp-14773493 systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:33 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:34 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:34 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:36 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_set_stream 1
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_mi_stop
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_s_comp
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_s_comp
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_s_comp
Mar 06 19:27:37 verdin-imx8mp-14773493 kernel: enter isp_mi_start



Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain gain=0
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain total_gain1=0x535
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain total_gain=0x535
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain gain=0
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain total_gain1=0x460
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_gain total_gain=0x460
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_exp exp=0x2a3
Mar 06 23:05:07 verdin-imx8mp-14773493 kernel: imx307_set_exp exp=0x2a3
Mar 06 23:04:50 verdin-imx8mp-14773493 kernel: ###### video2(0) 13.99 fps ######
Mar 06 23:04:19 verdin-imx8mp-14773493 kernel: ###### video2(0) 13.99 fps ######

[khang_letruong]

Hi @alvaro_tx,

Did you properly stop the isp service prior calling start_isp.sh?

systemctl stop imx8-isp.service

Regards,

Khang