"Too late to run INIT block at /usr/local/share/perl/5.34.0/Zonemaster/Engine.pm line 31." log message

[PolaricEntropy]

When running zm-rpcapi on Ubuntu 22.04 LTS I see the message Too late to run INIT block at /usr/local/share/perl/5.34.0/Zonemaster/Engine.pm line 31. when running systemctl status zm-rpcapi

Mar 03 09:15:06 zonemaster-backend-dev-eu-north-1c systemd[1]: Starting LSB: A JSON-RPC frontend for Zonemaster Backend...
Mar 03 09:15:12 zonemaster-backend-dev-eu-north-1c zm-rpcapi[1081]: Too late to run INIT block at /usr/local/share/perl/5.34.0/Zonemaster/Engine.pm line 31.
Mar 03 09:15:14 zonemaster-backend-dev-eu-north-1c zm-rpcapi[1081]: 2025-03-03T09:15:14Z [1081] [NOTICE] [Zonemaster::Backend::Config] Loading config: /etc/zonemaster/backend_config.ini
Mar 03 09:15:14 zonemaster-backend-dev-eu-north-1c zm-rpcapi[1081]: 2025-03-03T09:15:14Z [1081] [INFO] [Plack::Sandbox::_2fusr_2flocal_2fbin_2fzonemaster_backend_rpcapi_2epsgi] Enabling add_api_user method
Mar 03 09:15:14 zonemaster-backend-dev-eu-north-1c zm-rpcapi[1081]: 2025-03-03T09:15:14Z [1081] [INFO] [Plack::Sandbox::_2fusr_2flocal_2fbin_2fzonemaster_backend_rpcapi_2epsgi] Enabling add_batch_job method
Mar 03 09:15:14 zonemaster-backend-dev-eu-north-1c systemd[1]: Started LSB: A JSON-RPC frontend for Zonemaster Backend.

[matsduf]

@PolaricEntropy, does this prevent Backend from running? Does this happen every time?

[tgreenx]

Hi @PolaricEntropy, thanks for the report.
It is a Perl warning (see https://perldoc.perl.org/perldiag#Too-late-to-run-%25s-block), which comes from an interaction between Starman (used to start the Backend) and Zonemaster-Engine. Starman uses the require keyword instead of use. But the content of the INIT block is then explicitly called by Backend during run-time (see https://github.com/zonemaster/zonemaster-backend/blob/v11.3.0/script/zonemaster_backend_rpcapi.psgi#L45), so no worries here.

Thus it can be safely ignored. We'll see if we can eventually come up with a solution though.

Full stack backtrace (using Carp::Always):

$  starman --preload-app script/zonemaster_backend_rpcapi.psgi
Too late to run INIT block at /home/tgreen/projects/zonemaster/zonemaster-engine/lib/Zonemaster/Engine.pm line 32.
        require Zonemaster/Engine.pm called at /home/tgreen/projects/zonemaster/zonemaster-backend/lib/Zonemaster/Backend/RPCAPI.pm line 24
        Zonemaster::Backend::RPCAPI::BEGIN() called at /home/tgreen/projects/zonemaster/zonemaster-backend/lib/Zonemaster/Backend/RPCAPI.pm line 24
        eval {...} called at /home/tgreen/projects/zonemaster/zonemaster-backend/lib/Zonemaster/Backend/RPCAPI.pm line 24
        require Zonemaster/Backend/RPCAPI.pm called at /home/tgreen/projects/zonemaster/zonemaster-backend/script/zonemaster_backend_rpcapi.psgi line 25
        Plack::Sandbox::_2fhome_2ftgreen_2fprojects_2fzonemaster_2fzonemaster_2dbackend_2fscript_2fzonemaster_backend_rpcapi_2epsgi::BEGIN() called at /home/tgreen/projects/zonemaster/zonemaster-backend/script/zonemaster_backend_rpcapi.psgi line 25
        eval {...} called at /home/tgreen/projects/zonemaster/zonemaster-backend/script/zonemaster_backend_rpcapi.psgi line 25
        require /home/tgreen/projects/zonemaster/zonemaster-backend/script/zonemaster_backend_rpcapi.psgi called at (eval 5) line 3
        eval 'package Plack::Sandbox::_2fhome_2ftgreen_2fprojects_2fzonemaster_2fzonemaster_2dbackend_2fscript_2fzonemaster_backend_rpcapi_2epsgi;
{
    my $app = do $_file;
    if ( !$app && ( my $error = $@ || $! )) { die $error; }
    $app;
}
' called at /usr/share/perl5/Plack/Util.pm line 120
        Plack::Util::_load_sandbox("/home/tgreen/projects/zonemaster/zonemaster-backend/script/zo"...) called at /usr/share/perl5/Plack/Util.pm line 136
        Plack::Util::load_psgi("script/zonemaster_backend_rpcapi.psgi") called at /usr/share/perl5/Plack/Runner.pm line 181
        Plack::Runner::__ANON__() called at /usr/share/perl5/Plack/Runner.pm line 24
        Plack::Runner::__ANON__() called at /usr/share/perl5/Plack/Loader.pm line 55
        Plack::Loader::preload_app(Plack::Loader=HASH(0x557c28a9aa30), CODE(0x557c28a9ab08)) called at /usr/share/perl5/Plack/Runner.pm line 276
        Plack::Runner::run(Plack::Runner=HASH(0x557c287f66c0)) called at /usr/bin/starman line 38

[ ... ]

[PolaricEntropy]

It does not prevent it from running. However, I thought it would be good to report this since there shouldn't be any warning/error messages by default if everything runs fine.

[matsduf]

We love to get such reports!