Whoops, looks like something went wrong. Check your librenms.log.

[dassic]

Hi!

Installing LibreNMS for the first time as a container, so likely something obvious I've missed. I initially got the 404 error mentioned elsewhere, but fixed that. Now I get a bit further and get the LibreNMS page stating that something went wrong. I've checked librenms.log and there's nothing.

Here's the output from docker-compose logs -f while starting :

Attaching to librenms_db, librenms_smtp, traefik, librenms_rrdcached, librenms_memcached
traefik      | time="2019-06-12T06:25:37Z" level=info msg="Traefik version v1.7.12 built on 2019-05-29_07:35:02PM"
traefik      | time="2019-06-12T06:25:37Z" level=info msg="\nStats collection is disabled.\nHelp us improve Traefik by turning this feature on :)\nMore details on: https://docs.traefik.io/basics/#collected-data\n"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Preparing server http &{Address::80 TLS:<nil> Redirect:0xc0005ca180 Auth:<nil> WhitelistSourceRange:[] WhiteList:<nil> Compress:false ProxyProtocol:<nil> ForwardedHeaders:0xc00065c080} with readTimeout=0s writeTimeout=0s idleTimeout=3m0s"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Preparing server https &{Address::443 TLS:0xc000478b40 Redirect:<nil> Auth:<nil> WhitelistSourceRange:[] WhiteList:<nil> Compress:false ProxyProtocol:<nil> ForwardedHeaders:0xc00065c180} with readTimeout=0s writeTimeout=0s idleTimeout=3m0s"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Starting server on :80"
rrdcached_1  | Setting timezone to America/Los_Angeles...
rrdcached_1  | Checking if rrdcached UID / GID has changed...
rrdcached_1  | Initializing LibreNMS files / folders...
rrdcached_1  | Creating RRDcached configuration...
rrdcached_1  | Fixing permissions...
rrdcached_1  | starting up
rrdcached_1  | setgid(1000) succeeded
rrdcached_1  | setuid(1000) succeeded
rrdcached_1  | checking for journal files
rrdcached_1  | journal processing complete
rrdcached_1  | listening for connections
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] mysqld (mysqld 10.2.24-MariaDB-1:10.2.24+maria~bionic) starting as process 1 ...
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Uses event mutexes
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Compressed tables use zlib 1.2.11
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Using Linux native AIO
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Number of pools: 1
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Using SSE2 crc32 instructions
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Initializing buffer pool, total size = 256M, instances = 1, chunk size = 128M
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Starting server on :443"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Starting provider configuration.ProviderAggregator {}"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Starting provider *docker.Provider {\"Watch\":true,\"Filename\":\"\",\"Constraints\":null,\"Trace\":false,\"TemplateVersion\":2,\"DebugLogGeneratedTemplate\":false,\"Endpoint\":\"unix:///var/run/docker.sock\",\"Domain\":\"intranet.dassic.com\",\"TLS\":null,\"ExposedByDefault\":false,\"UseBindPortIP\":false,\"SwarmMode\":false,\"Network\":\"\",\"SwarmModeRefreshSeconds\":15}"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Starting provider *acme.Provider {\"Email\":\"webmaster@example.com\",\"ACMELogging\":true,\"CAServer\":\"https://acme-v02.api.letsencrypt.org/directory\",\"Storage\":\"acme.json\",\"EntryPoint\":\"https\",\"KeyType\":\"\",\"OnHostRule\":true,\"OnDemand\":false,\"DNSChallenge\":null,\"HTTPChallenge\":{\"EntryPoint\":\"http\"},\"TLSChallenge\":null,\"Domains\":null,\"Store\":{}}"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Testing certificate renew..."
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Completed initialization of buffer pool
db_1         | 2019-06-11 23:25:38 139764008281856 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
db_1         | 2019-06-11 23:25:38 139764735935808 [Note] InnoDB: Highest supported file format is Barracuda.
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Server configuration reloaded on :80"
traefik      | time="2019-06-12T06:25:38Z" level=info msg="Server configuration reloaded on :443"
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] InnoDB: 128 out of 128 rollback segments are active.
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] InnoDB: Creating shared tablespace for temporary tables
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] InnoDB: 5.7.26 started; log sequence number 4481943
db_1         | 2019-06-11 23:25:39 139763713558272 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] Plugin 'FEEDBACK' is disabled.
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] Server socket created on IP: '::'.
db_1         | 2019-06-11 23:25:39 139764735935808 [Warning] 'proxies_priv' entry '@% root@4c75ee35f5d9' ignored in --skip-name-resolve mode.
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] Reading of all Master_info entries succeded
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] Added new Master_info '' to hash table
db_1         | 2019-06-11 23:25:39 139764735935808 [Note] mysqld: ready for connections.
db_1         | Version: '10.2.24-MariaDB-1:10.2.24+maria~bionic'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  mariadb.org binary distribution
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:25:39Z" level=info msg="Server configuration reloaded on :80"
traefik      | time="2019-06-12T06:25:39Z" level=info msg="Server configuration reloaded on :443"
librenms     | Setting timezone to America/Los_Angeles...
librenms     | Checking if librenms UID / GID has changed...
librenms     | Setting PHP-FPM configuration...
librenms     | Setting PHP INI configuration...
librenms     | Setting OpCache configuration...
librenms     | Setting Nginx configuration...
librenms     | Updating SNMP community...
librenms     | Initializing LibreNMS files / folders...
librenms     | Setting LibreNMS configuration...
librenms     | Fixing permissions...
librenms     | Checking additional Monitoring plugins...
librenms     | Waiting 30s for database to be ready...
librenms     | Database ready!
librenms     | Updating database schema...
librenms     | Nothing to migrate.
librenms     | 2019-06-11 23:25:40,984 INFO Included extra file "/etc/supervisord/nginx.conf" during parsing
librenms     | 2019-06-11 23:25:40,984 INFO Included extra file "/etc/supervisord/php.conf" during parsing
librenms     | 2019-06-11 23:25:40,984 INFO Included extra file "/etc/supervisord/snmpd.conf" during parsing
librenms     | 2019-06-11 23:25:40,984 INFO Set uid to user 0 succeeded
librenms     | 2019-06-11 23:25:40,998 INFO RPC interface 'supervisor' initialized
librenms     | 2019-06-11 23:25:40,999 CRIT Server 'unix_http_server' running without any HTTP authentication checking
librenms     | 2019-06-11 23:25:40,999 INFO supervisord started with pid 1
db_1         | 2019-06-11 23:25:41 139763713558272 [Note] InnoDB: Buffer pool(s) load completed at 190611 23:25:41
librenms_smtp exited with code 1
librenms     | 2019-06-11 23:25:42,002 INFO spawned: 'nginx' with pid 52
librenms     | 2019-06-11 23:25:42,004 INFO spawned: 'php' with pid 53
librenms     | 2019-06-11 23:25:42,006 INFO spawned: 'snmpd' with pid 54
librenms     | 2019/06/11 23:25:42 [notice] 52#52: using the "epoll" event method
librenms     | 2019/06/11 23:25:42 [notice] 52#52: nginx/1.14.2
librenms     | 2019/06/11 23:25:42 [notice] 52#52: OS: Linux 3.10.0-957.21.2.el7.x86_64
librenms     | 2019/06/11 23:25:42 [notice] 52#52: getrlimit(RLIMIT_NOFILE): 1048576:1048576
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker processes
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 55
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 56
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 57
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 58
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 59
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 60
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 61
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 63
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 72
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 88
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 104
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 130
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 152
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 174
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 187
librenms     | 2019/06/11 23:25:42 [notice] 52#52: start worker process 199
librenms     | [11-Jun-2019 23:25:42] NOTICE: fpm is running, pid 53
librenms     | [11-Jun-2019 23:25:42] NOTICE: ready to handle connections
librenms     | 2019-06-11 23:25:43,071 INFO success: nginx entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
librenms     | 2019-06-11 23:25:43,072 INFO success: php entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
librenms     | 2019-06-11 23:25:43,072 INFO success: snmpd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
librenms_syslog | Setting timezone to America/Los_Angeles...
librenms_syslog | Checking if librenms UID / GID has changed...
librenms_syslog | Setting PHP-FPM configuration...
librenms_syslog | Setting PHP INI configuration...
librenms_syslog | Setting OpCache configuration...
librenms_syslog | Setting Nginx configuration...
librenms_syslog | Updating SNMP community...
librenms_syslog | Initializing LibreNMS files / folders...
librenms_syslog | Setting LibreNMS configuration...
librenms_syslog | Fixing permissions...
librenms_syslog | Checking additional Monitoring plugins...
librenms_syslog | >>
librenms_syslog | >> Sidecar syslog-ng container detected
librenms_syslog | >>
cron_1       | Setting timezone to America/Los_Angeles...
cron_1       | Checking if librenms UID / GID has changed...
cron_1       | Setting PHP-FPM configuration...
cron_1       | Setting PHP INI configuration...
cron_1       | Setting OpCache configuration...
cron_1       | Setting Nginx configuration...
cron_1       | Updating SNMP community...
cron_1       | Initializing LibreNMS files / folders...
cron_1       | Setting LibreNMS configuration...
cron_1       | Fixing permissions...
librenms_syslog | 2019-06-11 23:25:43,424 INFO Included extra file "/etc/supervisord/syslog-ng.conf" during parsing
librenms_syslog | 2019-06-11 23:25:43,424 INFO Set uid to user 0 succeeded
librenms_syslog | 2019-06-11 23:25:43,433 INFO RPC interface 'supervisor' initialized
librenms_syslog | 2019-06-11 23:25:43,433 CRIT Server 'unix_http_server' running without any HTTP authentication checking
librenms_syslog | 2019-06-11 23:25:43,433 INFO supervisord started with pid 1
traefik      | time="2019-06-12T06:25:43Z" level=info msg="Server configuration reloaded on :80"
traefik      | time="2019-06-12T06:25:43Z" level=info msg="Server configuration reloaded on :443"
traefik      | time="2019-06-12T06:25:43Z" level=info msg="The key type is empty. Use default key type 4096."
cron_1       | Checking additional Monitoring plugins...
cron_1       | >>
cron_1       | >> Sidecar cron container detected
cron_1       | >>
cron_1       | Fixing crontab permissions...
cron_1       | 2019-06-11 23:25:43,815 INFO Included extra file "/etc/supervisord/cron.conf" during parsing
cron_1       | 2019-06-11 23:25:43,815 INFO Set uid to user 0 succeeded
cron_1       | 2019-06-11 23:25:43,824 INFO RPC interface 'supervisor' initialized
cron_1       | 2019-06-11 23:25:43,825 CRIT Server 'unix_http_server' running without any HTTP authentication checking
cron_1       | 2019-06-11 23:25:43,825 INFO supervisord started with pid 1
librenms_syslog | 2019-06-11 23:25:44,436 INFO spawned: 'syslog-ng' with pid 39
librenms_syslog | [2019-06-11T23:25:44.445635] WARNING: Configuration file format is too old, syslog-ng is running in compatibility mode. Please update it to use the syslog-ng 3.19 format at your time of convenience. To upgrade the configuration, please review the warnings about incompatible changes printed by syslog-ng, and once completed change the @version header at the top of the configuration file.;
librenms_syslog | [2019-06-11T23:25:44.449226] WARNING: With use-dns(no), dns-cache() will be forced to 'no' too!;
librenms_smtp exited with code 1
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:25:44Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:25:44Z" level=info msg="Skipping same configuration for provider docker"
cron_1       | 2019-06-11 23:25:44,828 INFO spawned: 'cron' with pid 45
cron_1       | crond: crond (busybox 1.29.3) started, log level 8
traefik      | time="2019-06-12T06:25:45Z" level=info msg="Server configuration reloaded on :443"
traefik      | time="2019-06-12T06:25:45Z" level=info msg="Server configuration reloaded on :80"
librenms_syslog | 2019-06-11 23:25:45,449 INFO success: syslog-ng entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
cron_1       | 2019-06-11 23:25:45,836 INFO success: cron entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
librenms_smtp exited with code 1
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:25:47Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:25:47Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:25:48Z" level=info msg=Register...
traefik      | time="2019-06-12T06:25:48Z" level=info msg="legolog: [INFO] acme: Registering account for webmaster@example.com"
traefik      | time="2019-06-12T06:25:48Z" level=error msg="Unable to obtain ACME certificate for domains \"dali.intranet.dassic.com\" detected thanks to rule \"Host:dali.intranet.dassic.com\" : cannot get ACME client acme: error: 400 :: POST :: https://acme-v02.api.letsencrypt.org/acme/new-acct :: urn:ietf:params:acme:error:invalidEmail :: Error creating new account :: invalid contact domain. Contact emails @example.com are forbidden, url: "
traefik      | time="2019-06-12T06:25:50Z" level=info msg="Skipping same configuration for provider docker"
librenms_smtp exited with code 1
traefik      | time="2019-06-12T06:25:51Z" level=info msg="Skipping same configuration for provider docker"
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:25:57Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:25:57Z" level=info msg="Skipping same configuration for provider docker"
cron_1       | crond: USER librenms pid  46 cmd /opt/librenms/alerts.php >> /dev/null 2>&1
traefik      | time="2019-06-12T06:26:11Z" level=info msg="Skipping same configuration for provider docker"
librenms_smtp exited with code 1
traefik      | time="2019-06-12T06:26:11Z" level=info msg="Skipping same configuration for provider docker"
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:26:38Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:26:38Z" level=info msg="Skipping same configuration for provider docker"
cron_1       | crond: USER librenms pid  47 cmd /opt/librenms/alerts.php >> /dev/null 2>&1
librenms_smtp exited with code 1
traefik      | time="2019-06-12T06:27:30Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:27:30Z" level=info msg="Skipping same configuration for provider docker"
cron_1       | crond: USER librenms pid  48 cmd /opt/librenms/alerts.php >> /dev/null 2>&1
librenms     | 10.0.0.41 - - [11/Jun/2019:23:28:41 -0700] "GET / HTTP/1.1" 500 5020 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/74.0.3729.169 Safari/537.36"
librenms     | - -  11/Jun/2019:23:28:41 -0700 "GET /index.php" 500
cron_1       | crond: USER librenms pid  49 cmd /opt/librenms/alerts.php >> /dev/null 2>&1
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
smtp_1       | SMTP_PASSWORD is not set
traefik      | time="2019-06-12T06:29:13Z" level=info msg="Skipping same configuration for provider docker"
traefik      | time="2019-06-12T06:29:13Z" level=info msg="Skipping same configuration for provider docker"

[crazy-max]

Hi @dassic, please create a proper bug report. Thanks.