mautic / docker-mautic

Docker Image for Mautic
https://www.mautic.org
377 stars 280 forks source link

latest docker image causes 500 error when finishing the install #142

Closed tcurdt closed 4 years ago

tcurdt commented 4 years ago

Bug Description

A fresh install via docker-compose fails during admin account creation (showing a 500). I can go to http://localhost:8080/installer/step/2 and try again, but whatever I put in it shows the same error.

The site is currently offline due to encountering an error. If the problem persists, please contact the system administrator.

Q A
Mautic version Docker image c88348b3ef3796e699c2c117db2739152587493eabdb39ca7680cb8621f6a310 (latest)
PHP version (see above)
Browser Google Chrome Version 78.0.3904.97 (Official Build) (64-bit) on macOS 10.15.1
% docker version
Client: Docker Engine - Community
 Version:           19.03.5
 API version:       1.40
 Go version:        go1.12.12
 Git commit:        633a0ea
 Built:             Wed Nov 13 07:22:34 2019
 OS/Arch:           darwin/amd64
 Experimental:      false

Server: Docker Engine - Community
 Engine:
  Version:          19.03.5
  API version:      1.40 (minimum version 1.12)
  Go version:       go1.12.12
  Git commit:       633a0ea
  Built:            Wed Nov 13 07:29:19 2019
  OS/Arch:          linux/amd64
  Experimental:     false
 containerd:
  Version:          v1.2.10
  GitCommit:        b34a5c8af56e510852c35414db4c1f4fa6172339
 runc:
  Version:          1.0.0-rc8+dev
  GitCommit:        3e425f80a8c931f88e6d94a8c831b9d5aa481657
 docker-init:
  Version:          0.18.0
  GitCommit:        fec3683

Steps to reproduce

version: '3.7'

services:
  mautic:
    image: mautic/mautic:latest
    links:
      - mauticdb:mysql
    ports:
      - 8080:80
    volumes:
      - ./mautic_data:/var/www/html
    environment:
      - MAUTIC_DB_HOST=mauticdb
      - MYSQL_PORT_3306_TCP=3306
      - MAUTIC_DB_USER=root
      - MAUTIC_DB_PASSWORD=mysecret
      - MAUTIC_DB_NAME=mautic
    networks:
      - mautic-net

  mauticdb:
    image: mysql:5.6
    environment:
      - MYSQL_ROOT_PASSWORD=mysecret
    networks:
      - mautic-net

networks:
  mautic-net:
    driver: bridge

Then call docker-compose up. Then go through the install wizard. When creating the admin accounts it fails with a 500 error.

Log errors

% docker-compose up                     
Creating downloads_mauticdb_1 ... done
Creating downloads_mautic_1   ... done
Attaching to downloads_mauticdb_1, downloads_mautic_1
mauticdb_1  | 2019-12-05 19:22:47+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 5.6.46-1debian9 started.
mauticdb_1  | 2019-12-05 19:22:47+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
mautic_1    | warning: both MAUTIC_DB_HOST and MYSQL_PORT_3306_TCP found
mautic_1    |   Connecting to MAUTIC_DB_HOST (mauticdb)
mautic_1    |   instead of the linked mysql container
mauticdb_1  | 2019-12-05 19:22:47+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 5.6.46-1debian9 started.
mauticdb_1  | 2019-12-05 19:22:47+00:00 [Note] [Entrypoint]: Initializing database files
mauticdb_1  | 2019-12-05 19:22:47 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
mauticdb_1  | 2019-12-05 19:22:47 0 [Note] Ignoring --secure-file-priv value as server is running with --bootstrap.
mauticdb_1  | 2019-12-05 19:22:47 0 [Note] /usr/sbin/mysqld (mysqld 5.6.46) starting as process 48 ...
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Using atomics to ref count buffer pool pages
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: The InnoDB memory heap is disabled
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Memory barrier is not used
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Compressed tables use zlib 1.2.11
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Using Linux native AIO
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Using CPU crc32 instructions
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Initializing buffer pool, size = 128.0M
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Completed initialization of buffer pool
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Database physically writes the file full: wait...
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Setting log file ./ib_logfile101 size to 48 MB
mauticdb_1  | 2019-12-05 19:22:47 48 [Note] InnoDB: Setting log file ./ib_logfile1 size to 48 MB
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
mauticdb_1  | 2019-12-05 19:22:48 48 [Warning] InnoDB: New log files created, LSN=45781
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Doublewrite buffer not found: creating new
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Doublewrite buffer created
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: 128 rollback segment(s) are active.
mauticdb_1  | 2019-12-05 19:22:48 48 [Warning] InnoDB: Creating foreign key constraint system tables.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Foreign key constraint system tables created
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Creating tablespace and datafile system tables.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Tablespace and datafile system tables created.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Waiting for purge to start
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: 5.6.46 started; log sequence number 0
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] RSA private key file not found: /var/lib/mysql//private_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] RSA public key file not found: /var/lib/mysql//public_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] Binlog end
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: FTS optimize thread exiting.
mauticdb_1  | 2019-12-05 19:22:48 48 [Note] InnoDB: Starting shutdown...
mautic_1    | 
mautic_1    | Ensuring Mautic database is present
mautic_1    | 
mautic_1    | Warning: mysqli::__construct(): (HY000/2002): Connection refused in /makedb.php on line 20
mautic_1    | 
mautic_1    | MySQL Connection Error: (2002) Connection refused
mauticdb_1  | 2019-12-05 19:22:50 48 [Note] InnoDB: Shutdown completed; log sequence number 1625977
mauticdb_1  | 
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:50 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
mauticdb_1  | 2019-12-05 19:22:50 0 [Note] Ignoring --secure-file-priv value as server is running with --bootstrap.
mauticdb_1  | 2019-12-05 19:22:50 0 [Note] /usr/sbin/mysqld (mysqld 5.6.46) starting as process 71 ...
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Using atomics to ref count buffer pool pages
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: The InnoDB memory heap is disabled
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Memory barrier is not used
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Compressed tables use zlib 1.2.11
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Using Linux native AIO
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Using CPU crc32 instructions
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Initializing buffer pool, size = 128.0M
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Completed initialization of buffer pool
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Highest supported file format is Barracuda.
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: 128 rollback segment(s) are active.
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Waiting for purge to start
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: 5.6.46 started; log sequence number 1625977
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] RSA private key file not found: /var/lib/mysql//private_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] RSA public key file not found: /var/lib/mysql//public_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] Binlog end
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: FTS optimize thread exiting.
mauticdb_1  | 2019-12-05 19:22:50 71 [Note] InnoDB: Starting shutdown...
mautic_1    | 
mautic_1    | Warning: mysqli::__construct(): (HY000/2002): Connection refused in /makedb.php on line 20
mautic_1    | 
mautic_1    | MySQL Connection Error: (2002) Connection refused
mauticdb_1  | 2019-12-05 19:22:52 71 [Note] InnoDB: Shutdown completed; log sequence number 1625987
mauticdb_1  | 
mauticdb_1  | 
mauticdb_1  | 
mauticdb_1  | 
mauticdb_1  | PLEASE REMEMBER TO SET A PASSWORD FOR THE MySQL root USER !
mauticdb_1  | To do so, start the server, then issue the following commands:
mauticdb_1  | 
mauticdb_1  |   /usr/bin/mysqladmin -u root password 'new-password'
mauticdb_1  |   /usr/bin/mysqladmin -u root -h 489b0450a186 password 'new-password'
mauticdb_1  | 
mauticdb_1  | Alternatively you can run:
mauticdb_1  | 
mauticdb_1  |   /usr/bin/mysql_secure_installation
mauticdb_1  | 
mauticdb_1  | which will also give you the option of removing the test
mauticdb_1  | databases and anonymous user created by default.  This is
mauticdb_1  | strongly recommended for production servers.
mauticdb_1  | 
mauticdb_1  | See the manual for more instructions.
mauticdb_1  | 
mauticdb_1  | Please report any problems at http://bugs.mysql.com/
mauticdb_1  | 
mauticdb_1  | The latest information about MySQL is available on the web at
mauticdb_1  | 
mauticdb_1  |   http://www.mysql.com
mauticdb_1  | 
mauticdb_1  | Support MySQL by buying support/licenses at http://shop.mysql.com
mauticdb_1  | 
mauticdb_1  | Note: new default config file not created.
mauticdb_1  | Please make sure your config file is current
mauticdb_1  | 
mauticdb_1  | WARNING: Default config file /etc/mysql/my.cnf exists on the system
mauticdb_1  | This file will be read by default by the MySQL server
mauticdb_1  | If you do not want to use this, either remove it, or use the
mauticdb_1  | --defaults-file argument to mysqld_safe when starting the server
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:52+00:00 [Note] [Entrypoint]: Database files initialized
mauticdb_1  | 2019-12-05 19:22:52+00:00 [Note] [Entrypoint]: Starting temporary server
mauticdb_1  | 2019-12-05 19:22:52+00:00 [Note] [Entrypoint]: Waiting for server startup
mauticdb_1  | 2019-12-05 19:22:52 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
mauticdb_1  | 2019-12-05 19:22:52 0 [Note] mysqld (mysqld 5.6.46) starting as process 96 ...
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] Plugin 'FEDERATED' is disabled.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Using atomics to ref count buffer pool pages
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: The InnoDB memory heap is disabled
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Memory barrier is not used
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Compressed tables use zlib 1.2.11
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Using Linux native AIO
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Using CPU crc32 instructions
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Initializing buffer pool, size = 128.0M
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Completed initialization of buffer pool
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Highest supported file format is Barracuda.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: 128 rollback segment(s) are active.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: Waiting for purge to start
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] InnoDB: 5.6.46 started; log sequence number 1625987
mauticdb_1  | 2019-12-05 19:22:52 96 [Warning] No existing UUID has been found, so we assume that this is the first time that this server has been started. Generating a new UUID: a1e63825-1794-11ea-81f5-0242ac140002.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] RSA private key file not found: /var/lib/mysql//private_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] RSA public key file not found: /var/lib/mysql//public_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:52 96 [Warning] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
mauticdb_1  | 2019-12-05 19:22:52 96 [Warning] 'user' entry 'root@489b0450a186' ignored in --skip-name-resolve mode.
mauticdb_1  | 2019-12-05 19:22:52 96 [Warning] 'user' entry '@489b0450a186' ignored in --skip-name-resolve mode.
mauticdb_1  | 2019-12-05 19:22:52 96 [Warning] 'proxies_priv' entry '@ root@489b0450a186' ignored in --skip-name-resolve mode.
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] Event Scheduler: Loaded 0 events
mauticdb_1  | 2019-12-05 19:22:52 96 [Note] mysqld: ready for connections.
mauticdb_1  | Version: '5.6.46'  socket: '/var/run/mysqld/mysqld.sock'  port: 0  MySQL Community Server (GPL)
mauticdb_1  | 2019-12-05 19:22:53+00:00 [Note] [Entrypoint]: Temporary server started.
mauticdb_1  | Warning: Unable to load '/usr/share/zoneinfo/iso3166.tab' as time zone. Skipping it.
mauticdb_1  | Warning: Unable to load '/usr/share/zoneinfo/leap-seconds.list' as time zone. Skipping it.
mautic_1    | 
mautic_1    | Warning: mysqli::__construct(): (HY000/2002): Connection refused in /makedb.php on line 20
mautic_1    | 
mautic_1    | MySQL Connection Error: (2002) Connection refused
mauticdb_1  | Warning: Unable to load '/usr/share/zoneinfo/zone.tab' as time zone. Skipping it.
mauticdb_1  | Warning: Unable to load '/usr/share/zoneinfo/zone1970.tab' as time zone. Skipping it.
mauticdb_1  | 2019-12-05 19:22:56 96 [Warning] 'proxies_priv' entry '@ root@489b0450a186' ignored in --skip-name-resolve mode.
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:56+00:00 [Note] [Entrypoint]: Stopping temporary server
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] mysqld: Normal shutdown
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Giving 0 client threads a chance to die gracefully
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Event Scheduler: Purging the queue. 0 events
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down slave threads
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Forcefully disconnecting 0 remaining clients
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Binlog end
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'partition'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'PERFORMANCE_SCHEMA'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_DATAFILES'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_TABLESPACES'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_FOREIGN_COLS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_FOREIGN'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_FIELDS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_COLUMNS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_INDEXES'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_TABLESTATS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_SYS_TABLES'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_INDEX_TABLE'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_INDEX_CACHE'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_CONFIG'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_BEING_DELETED'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_DELETED'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_FT_DEFAULT_STOPWORD'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_METRICS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_BUFFER_POOL_STATS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_BUFFER_PAGE_LRU'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_BUFFER_PAGE'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMP_PER_INDEX_RESET'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMP_PER_INDEX'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMPMEM_RESET'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMPMEM'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMP_RESET'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_CMP'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_LOCK_WAITS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_LOCKS'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'INNODB_TRX'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] Shutting down plugin 'InnoDB'
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] InnoDB: FTS optimize thread exiting.
mauticdb_1  | 2019-12-05 19:22:56 96 [Note] InnoDB: Starting shutdown...
mautic_1    | 
mautic_1    | Warning: mysqli::__construct(): (HY000/2002): Connection refused in /makedb.php on line 20
mautic_1    | 
mautic_1    | MySQL Connection Error: (2002) Connection refused
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] InnoDB: Shutdown completed; log sequence number 1625997
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'BLACKHOLE'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'ARCHIVE'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'MRG_MYISAM'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'MyISAM'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'MEMORY'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'CSV'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'sha256_password'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'mysql_old_password'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'mysql_native_password'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] Shutting down plugin 'binlog'
mauticdb_1  | 2019-12-05 19:22:58 96 [Note] mysqld: Shutdown complete
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:58+00:00 [Note] [Entrypoint]: Temporary server stopped
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:58+00:00 [Note] [Entrypoint]: MySQL init process done. Ready for start up.
mauticdb_1  | 
mauticdb_1  | 2019-12-05 19:22:59 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
mauticdb_1  | 2019-12-05 19:22:59 0 [Note] mysqld (mysqld 5.6.46) starting as process 1 ...
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] Plugin 'FEDERATED' is disabled.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Using atomics to ref count buffer pool pages
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: The InnoDB memory heap is disabled
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Memory barrier is not used
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Compressed tables use zlib 1.2.11
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Using Linux native AIO
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Using CPU crc32 instructions
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Initializing buffer pool, size = 128.0M
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Completed initialization of buffer pool
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Highest supported file format is Barracuda.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: 128 rollback segment(s) are active.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: Waiting for purge to start
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] InnoDB: 5.6.46 started; log sequence number 1625997
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] RSA private key file not found: /var/lib/mysql//private_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] RSA public key file not found: /var/lib/mysql//public_key.pem. Some authentication plugins will not work.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] Server hostname (bind-address): '*'; port: 3306
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] IPv6 is available.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note]   - '::' resolves to '::';
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] Server socket created on IP: '::'.
mauticdb_1  | 2019-12-05 19:22:59 1 [Warning] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
mauticdb_1  | 2019-12-05 19:22:59 1 [Warning] 'proxies_priv' entry '@ root@489b0450a186' ignored in --skip-name-resolve mode.
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] Event Scheduler: Loaded 0 events
mauticdb_1  | 2019-12-05 19:22:59 1 [Note] mysqld: ready for connections.
mauticdb_1  | Version: '5.6.46'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  MySQL Community Server (GPL)
mautic_1    | 
mautic_1    | MySQL Database Created
mautic_1    | ========================================================================
mautic_1    | 
mautic_1    | This server is now configured to run Mautic!
mautic_1    | The following information will be prefilled into the installer (keep password field empty):
mautic_1    | Host Name: mauticdb
mautic_1    | Database Name: mautic
mautic_1    | Database Username: root
mautic_1    | Database Password: mysecret
mautic_1    | 
mautic_1    | ========================================================================
mautic_1    | AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 172.20.0.3. Set the 'ServerName' directive globally to suppress this message
mautic_1    | AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 172.20.0.3. Set the 'ServerName' directive globally to suppress this message
mautic_1    | [Thu Dec 05 19:23:01.019852 2019] [mpm_prefork:notice] [pid 14] AH00163: Apache/2.4.38 (Debian) PHP/7.1.33 configured -- resuming normal operations
mautic_1    | [Thu Dec 05 19:23:01.019969 2019] [core:notice] [pid 14] AH00094: Command line: 'apache2 -D FOREGROUND'
mautic_1    | [CRON] Success!
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:24:40 +0000] "GET / HTTP/1.1" 302 683 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:24:40 +0000] "GET /installer HTTP/1.1" 200 9388 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:24:59 +0000] "POST /installer/step/0 HTTP/1.1" 302 600 "http://localhost:8080/installer" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:25:04 +0000] "GET /installer/step/1 HTTP/1.1" 200 14274 "http://localhost:8080/installer" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [DoctrineDBALExceptionTableNotFoundException]
mautic_1    | [CRON] An exception occurred while executing 'SELECT r0_.id AS id_0, r0_.schedule_date AS schedule_date_1, r1_.is_published AS is_published_2, r1_.date_added AS date_added_3, r1_.created_by AS created_by_4, r1_.created_by_user AS created_by_user_5, r1_.date_modified AS date_modified_6, r1_.modified_by AS modified_by_7, r1_.modified_by_user AS modified_by_user_8, r1_.checked_out AS checked_out_9, r1_.checked_out_by AS checked_out_by_10, r1_.checked_out_by_user AS checked_out_by_user_11, r1_.id AS id_12, r1_.name AS name_13, r1_.description AS description_14, r1_.`system` AS system_15, r1_.source AS source_16, r1_.columns AS columns_17, r1_.filters AS filters_18, r1_.table_order AS table_order_19, r1_.graphs AS graphs_20, r1_.group_by AS group_by_21, r1_.aggregators AS aggregators_22, r1_.settings AS settings_23, r1_.is_scheduled AS is_scheduled_24, r1_.schedule_unit AS schedule_unit_25, r1_.to_address AS to_address_26, r1_.schedule_day AS schedule_day_27, r1_.schedule_month_frequency AS schedule_month_frequency_28, r0_.report_id AS report_id_29 FROM reports_schedulers r0_ LEFT JOIN reports r1_ ON r0_.report_id = r1_.id WHERE r0_.schedule_date <= ?' with params ["2019-12-05 19:25:10"]:
mautic_1    | [CRON] 
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.reports_schedulers' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [DoctrineDBALDriverPDOException]
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.reports_schedulers' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [PDOException]
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.reports_schedulers' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] mautic:reports:scheduler [-report|--report [REPORT]] [-h|--help] [-q|--quiet] [-v|vv|vvv|--verbose] [-V|--version] [--ansi] [--no-ansi] [-n|--no-interaction] [-s|--shell] [--process-isolation] [-e|--env ENV] [--no-debug] [--] <command>
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [DoctrineDBALExceptionTableNotFoundException]
mautic_1    | [CRON] An exception occurred while executing 'SELECT i0_.is_published AS is_published_0, i0_.date_added AS date_added_1, i0_.created_by AS created_by_2, i0_.created_by_user AS created_by_user_3, i0_.date_modified AS date_modified_4, i0_.modified_by AS modified_by_5, i0_.modified_by_user AS modified_by_user_6, i0_.checked_out AS checked_out_7, i0_.checked_out_by AS checked_out_by_8, i0_.checked_out_by_user AS checked_out_by_user_9, i0_.id AS id_10, i0_.dir AS dir_11, i0_.file AS file_12, i0_.original_file AS original_file_13, i0_.line_count AS line_count_14, i0_.inserted_count AS inserted_count_15, i0_.updated_count AS updated_count_16, i0_.ignored_count AS ignored_count_17, i0_.priority AS priority_18, i0_.status AS status_19, i0_.date_started AS date_started_20, i0_.date_ended AS date_ended_21, i0_.object AS object_22, i0_.properties AS properties_23 FROM imports i0_ WHERE i0_.status IN (1, 7) ORDER BY i0_.priority ASC, i0_.date_added DESC LIMIT 1 OFFSET 0':
mautic_1    | [CRON] 
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.imports' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [DoctrineDBALDriverPDOException]
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.imports' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] [PDOException]
mautic_1    | [CRON] SQLSTATE[42S02]: Base table or view not found: 1146 Table 'mautic.imports' doesn't exist
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] mautic:import [-i|--id [ID]] [-l|--limit [LIMIT]] [-h|--help] [-q|--quiet] [-v|vv|vvv|--verbose] [-V|--version] [--ansi] [--no-ansi] [-n|--no-interaction] [-s|--shell] [--process-isolation] [-e|--env ENV] [--no-debug] [--] <command>
mautic_1    | [CRON] 
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:26:11 +0000] "POST /installer/step/1 HTTP/1.1" 302 610 "http://localhost:8080/installer/step/1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:26:17 +0000] "GET /installer/step/1.1 HTTP/1.1" 302 609 "http://localhost:8080/installer/step/1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:26:42 +0000] "GET /installer/step/1.2 HTTP/1.1" 302 599 "http://localhost:8080/installer/step/1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:26:47 +0000] "GET /installer/step/2 HTTP/1.1" 200 11188 "http://localhost:8080/installer/step/1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:27:08 +0000] "POST /installer/step/2 HTTP/1.1" 500 62033 "http://localhost:8080/installer/step/2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:28:22 +0000] "POST /s/ajax?action=updateUserStatus&mauticUserLastActive=61 HTTP/1.1" 302 887 "http://localhost:8080/installer/step/2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | 172.20.0.1 - - [05/Dec/2019:19:28:22 +0000] "GET /installer HTTP/1.1" 200 4553 "http://localhost:8080/installer/step/2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36"
mautic_1    | [CRON] Mautic is not set to queue email.
mautic_1    | [CRON] No mailboxes are configured.
mautic_1    | [CRON] Processing message queue
mautic_1    | [CRON] Webhook Bundle is in immediate process mode. To use the command function change to command mode.
mautic_1    | [CRON] Scheduler has finished
mautic_1    | [CRON] Messages sent: 0
mautic_1    | [CRON] 
mautic_1    | [CRON] No published monitors found. Make sure the id you supplied is published
mautic_1    | [CRON] 
mautic_1    | [CRON] 
mautic_1    | [CRON] +---------+--------+----------+
mautic_1    | [CRON] | Channel | # sent | # failed |
mautic_1    | [CRON] +---------+--------+----------+
mautic_1    | [CRON] Scheduler has finished
RCheesley commented 4 years ago

@tcurdt I've moved this to the Docker repo which I think is the most appropriate place for the issue :) Pinging @luizeof

tcurdt commented 4 years ago

@RCheesley Sorry - picked the wrong tab. Thanks for the transfer!

I guess that also explains why I didn't see https://github.com/mautic/docker-mautic/issues/141 ...but mine has a few more details.

tcurdt commented 4 years ago

@luizeof at least for me this hasn't fixed the issue yet

With the current docker-compose.yml I am getting:

% docker-compose up
ERROR: Named volume "mysql_data:/var/lib/mysql:rw" is used in service "mauticdb" but no declaration was found in the volumes section.

I modified the old one to

version: '3.7'

services:
  mautic:
    image: mautic/mautic:latest
    links:
      - mauticdb:mysql
    depends_on:
      - mauticdb
    ports:
      - 8080:80
    volumes:
      - ./mautic_data:/var/www/html
    environment:
      - MAUTIC_DB_HOST=mauticdb
      - MYSQL_PORT_3306_TCP=3306
      - MAUTIC_DB_USER=root
      - MAUTIC_DB_PASSWORD=mysecret
      - MAUTIC_DB_NAME=mautic
      - MAUTIC_RUN_CRON_JOBS=true
    networks:
      - mautic-net

  mauticdb:
    image: mysql:5.7
    environment:
      - MYSQL_ROOT_PASSWORD=mysecret
    networks:
      - mautic-net

networks:
  mautic-net:
    driver: bridge

but I am still getting the very same problem on step 2.

Could you elaborate what's going on?

elitekode2 commented 4 years ago

I am getting the same issue still with docker-compose as well

tcurdt commented 4 years ago

@elitekode2 TBH I don't see the big difference between the two docker compose files but I manage to start it up with the following. Maybe it works for you, too?

version: "2"
services:
  mautic:
    image: mautic/mautic
    depends_on:
      - mysql
    ports:
      - "8080:80"
    environment:
      MAUTIC_DB_HOST: mysql
      MAUTIC_DB_USER: mautic
      MAUTIC_DB_PASSWORD: mauticdbpass
      MAUTIC_TRUSTED_PROXIES: 0.0.0.0/0
    volumes:
      - mautic-web:/var/www/html

  mysql:
    image: mysql:5.6
    environment:
      MYSQL_ROOT_PASSWORD: mysqlrootpassword
      MYSQL_DATABASE: mautic
      MYSQL_USER: mautic
      MYSQL_PASSWORD: mauticdbpass
    volumes:
      - mysql:/var/lib/mysql

volumes:
  mautic-web:
  mysql:
sheksushant commented 4 years ago

@luizeof at least for me this hasn't fixed the issue yet

With the current docker-compose.yml I am getting:

% docker-compose up
ERROR: Named volume "mysql_data:/var/lib/mysql:rw" is used in service "mauticdb" but no declaration was found in the volumes section.

I modified the old one to

version: '3.7'

services:
  mautic:
    image: mautic/mautic:latest
    links:
      - mauticdb:mysql
    depends_on:
      - mauticdb
    ports:
      - 8080:80
    volumes:
      - ./mautic_data:/var/www/html
    environment:
      - MAUTIC_DB_HOST=mauticdb
      - MYSQL_PORT_3306_TCP=3306
      - MAUTIC_DB_USER=root
      - MAUTIC_DB_PASSWORD=mysecret
      - MAUTIC_DB_NAME=mautic
      - MAUTIC_RUN_CRON_JOBS=true
    networks:
      - mautic-net

  mauticdb:
    image: mysql:5.7
    environment:
      - MYSQL_ROOT_PASSWORD=mysecret
    networks:
      - mautic-net

networks:
  mautic-net:
    driver: bridge

but I am still getting the very same problem on step 2.

Could you elaborate what's going on?

I am getting the same issue on a DO droplet with Docker version 19.03.1, build 74b1e89 on Ubuntu 18.04