Как исправить ошибку при деплое Strapi на Heroku?

Question

[Игорь Мясников]

Возникает ошибка при подключении к БД Mongo Atlas на Heroku

Ошибка при подключении

2020-01-14T06:45:45.473Z] debug ⛔ Server wasn't able to start properly.
2020-01-14T06:45:45.474867+00:00 app[web.1]: [2020-01-14T06:45:45.474Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms

При локальном запуске все работает!

Настройки production/database

{
  "defaultConnection": "default",
  "connections": {
    "default": {
      "connector": "mongoose",
      "settings": {
        "host": "${process.env.DATABASE_HOST || '127.0.0.1'}",
        "port": "${process.env.DATABASE_PORT || 27017}",
        "database": "${process.env.DATABASE_NAME || 'strapi'}",
        "username": "${process.env.DATABASE_USERNAME || ''}",
        "password": "${process.env.DATABASE_PASSWORD || ''}"
      },
      "options": {}
    }
  }
}

Прописывал подключение и через uri - результат тот же

Настройки production/database

{
  "defaultConnection": "default",
  "connections": {
    "default": {
      "connector": "mongoose",
      "settings": {
        "uri": "${process.env.DATABASE_URI}",
        "database": "${process.env.DATABASE_NAME}"
      },
      "options": {
        "ssl": true
      }
    }
  }
}

В config vars Heroku все прописано

Доступ к БД открыт

Answer 1

[Everything_is_not_so_bad]

Какой командой запуска проверял локально? heroku local ?

Показывает ли heroku config правильные значения переменных DATABASE_ ?
Соответственно, не localhost...

Comments

[Игорь Мясников]

Да, проверял через heroku local - все запускается.

Значения переменных DATABASE_URI и DATABASE_NAME - прописаны в настройках Heroku в разделе Config Vars

[Everything_is_not_so_bad]

Игорь Мясников, они точно указывают на удаленную СУБД?

[Игорь Мясников]

Да uri и имя базы правильные , я перепроверял несколько раз

[Игорь Мясников]

Все ссылки копировал с develop режима напрямую в секцию config vars в настройках heroku.
Heroku config выдает

heroku config

»   Error: Couldn't find that app.
 »
 »   Error ID: not_found

[Everything_is_not_so_bad]

Игорь Мясников, попробуй выводить в лог приложения значения переменных для подключения, в кавычках.

Можно еще подключиться к контейнеру так:
heroku ps:exec https://devcenter.heroku.com/articles/exec
и проверить каковы значения.

[Everything_is_not_so_bad]

вот эту конфигурацию и нужно проверять

{
  "defaultConnection": "default",
  "connections": {
    "default": {
      "connector": "mongoose",
      "settings": {
        "uri": "${process.env.DATABASE_URI}",
        "database": "${process.env.DATABASE_NAME}"
      },
      "options": {
        "ssl": true
      }
    }
  }
}

В логи нужно выводить из кода прямо перед самим подключением к СУБД.

[Игорь Мясников]

Попробую посмотреть таким способом. А если в dashboard Heroku их показывает верно ?

[Игорь Мясников]

heroku config выдает нужные переменные , правильные , но все равно ошибка осталась

[Everything_is_not_so_bad]

Игорь Мясников, остается еще вероятность ошибки в коде, поэтому нужны логи.

[Игорь Мясников]

Как доберусь до компа посмотрю логи

[Игорь Мясников]

Log

> strapi start
2020-01-14T14:00:29.386789+00:00 app[web.1]: 
2020-01-14T14:01:01.352388+00:00 app[web.1]: [2020-01-14T14:01:01.351Z] debug ⛔️ Server wasn't able to start properly.
2020-01-14T14:01:01.353254+00:00 app[web.1]: [2020-01-14T14:01:01.353Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms
2020-01-14T14:01:01.363051+00:00 app[web.1]: npm ERR! code ELIFECYCLE
2020-01-14T14:01:01.363352+00:00 app[web.1]: npm ERR! errno 1
2020-01-14T14:01:01.364222+00:00 app[web.1]: npm ERR! crb-cms@0.1.0 start: `strapi start`
2020-01-14T14:01:01.364310+00:00 app[web.1]: npm ERR! Exit status 1
2020-01-14T14:01:01.364437+00:00 app[web.1]: npm ERR!
2020-01-14T14:01:01.364515+00:00 app[web.1]: npm ERR! Failed at the crb-cms@0.1.0 start script.
2020-01-14T14:01:01.364580+00:00 app[web.1]: npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
2020-01-14T14:01:01.371572+00:00 app[web.1]: 
2020-01-14T14:01:01.371769+00:00 app[web.1]: npm ERR! A complete log of this run can be found in:
2020-01-14T14:01:01.371875+00:00 app[web.1]: npm ERR!     /app/.npm/_logs/2020-01-14T14_01_01_365Z-debug.log
2020-01-14T14:01:01.438216+00:00 heroku[web.1]: State changed from starting to crashed
2020-01-14T14:01:01.420584+00:00 heroku[web.1]: Process exited with status 1
2020-01-14T14:41:25.387222+00:00 heroku[web.1]: State changed from crashed to starting
2020-01-14T14:41:42.932332+00:00 heroku[web.1]: Starting process with command `npm start`
2020-01-14T14:41:46.490871+00:00 app[web.1]: [heroku-exec] Starting
2020-01-14T14:41:47.405860+00:00 app[web.1]: 
2020-01-14T14:41:47.405885+00:00 app[web.1]: > crb-cms@0.1.0 start /app
2020-01-14T14:41:47.405887+00:00 app[web.1]: > strapi start
2020-01-14T14:41:47.405889+00:00 app[web.1]:
2020-01-14T14:42:21.949605+00:00 app[web.1]: [2020-01-14T14:42:21.948Z] debug ⛔️ Server wasn't able to start properly.
2020-01-14T14:42:21.952752+00:00 app[web.1]: [2020-01-14T14:42:21.952Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms
2020-01-14T14:42:22.061817+00:00 app[web.1]: npm ERR! code ELIFECYCLE
2020-01-14T14:42:22.063777+00:00 app[web.1]: npm ERR! errno 1
2020-01-14T14:42:22.065377+00:00 app[web.1]: npm ERR! crb-cms@0.1.0 start: `strapi start`
2020-01-14T14:42:22.065641+00:00 app[web.1]: npm ERR! Exit status 1
2020-01-14T14:42:22.065856+00:00 app[web.1]: npm ERR!
2020-01-14T14:42:22.066035+00:00 app[web.1]: npm ERR! Failed at the crb-cms@0.1.0 start script.
2020-01-14T14:42:22.066228+00:00 app[web.1]: npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
2020-01-14T14:42:22.372185+00:00 app[web.1]:
2020-01-14T14:42:22.397863+00:00 app[web.1]: npm ERR! A complete log of this run can be found in:
2020-01-14T14:42:22.398177+00:00 app[web.1]: npm ERR!     /app/.npm/_logs/2020-01-14T14_42_22_067Z-debug.log
2020-01-14T14:42:22.537655+00:00 heroku[web.1]: State changed from starting to crashed
2020-01-14T14:42:22.522679+00:00 heroku[web.1]: Process exited with status 1
2020-01-14T16:04:55.594793+00:00 heroku[web.1]: State changed from crashed to starting
2020-01-14T16:05:07.498066+00:00 heroku[web.1]: Starting process with command `npm start`
2020-01-14T16:05:09.885667+00:00 app[web.1]: [heroku-exec] Starting
2020-01-14T16:05:10.277560+00:00 app[web.1]:
2020-01-14T16:05:10.277589+00:00 app[web.1]: > crb-cms@0.1.0 start /app
2020-01-14T16:05:10.277592+00:00 app[web.1]: > strapi start
2020-01-14T16:05:10.277593+00:00 app[web.1]:
2020-01-14T16:05:42.875007+00:00 app[web.1]: [2020-01-14T16:05:42.874Z] debug ⛔️ Server wasn't able to start properly.
2020-01-14T16:05:42.876506+00:00 app[web.1]: [2020-01-14T16:05:42.876Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms
2020-01-14T16:05:42.892523+00:00 app[web.1]: npm ERR! code ELIFECYCLE
2020-01-14T16:05:42.893091+00:00 app[web.1]: npm ERR! errno 1
2020-01-14T16:05:42.894215+00:00 app[web.1]: npm ERR! crb-cms@0.1.0 start: `strapi start`
2020-01-14T16:05:42.894411+00:00 app[web.1]: npm ERR! Exit status 1
2020-01-14T16:05:42.894624+00:00 app[web.1]: npm ERR!
2020-01-14T16:05:42.894790+00:00 app[web.1]: npm ERR! Failed at the crb-cms@0.1.0 start script.
2020-01-14T16:05:42.894935+00:00 app[web.1]: npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
2020-01-14T16:05:42.902967+00:00 app[web.1]:
2020-01-14T16:05:42.903272+00:00 app[web.1]: npm ERR! A complete log of this run can be found in:
2020-01-14T16:05:42.903416+00:00 app[web.1]: npm ERR!     /app/.npm/_logs/2020-01-14T16_05_42_896Z-debug.log
2020-01-14T16:05:43.000055+00:00 heroku[web.1]: State changed from starting to crashed
2020-01-14T16:05:42.985116+00:00 heroku[web.1]: Process exited with status 1
2020-01-14T19:06:55.585041+00:00 heroku[web.1]: State changed from crashed to starting
2020-01-14T19:07:10.942590+00:00 heroku[web.1]: Starting process with command `npm start`
2020-01-14T19:07:14.298892+00:00 app[web.1]: [heroku-exec] Starting
2020-01-14T19:07:14.972428+00:00 app[web.1]:
2020-01-14T19:07:14.972442+00:00 app[web.1]: > crb-cms@0.1.0 start /app
2020-01-14T19:07:14.972445+00:00 app[web.1]: > strapi start
2020-01-14T19:07:14.972448+00:00 app[web.1]:
2020-01-14T19:07:48.286113+00:00 app[web.1]: [2020-01-14T19:07:48.285Z] debug ⛔️ Server wasn't able to start properly.
2020-01-14T19:07:48.291057+00:00 app[web.1]: [2020-01-14T19:07:48.290Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms
2020-01-14T19:07:48.331497+00:00 app[web.1]: npm ERR! code ELIFECYCLE
2020-01-14T19:07:48.335982+00:00 app[web.1]: npm ERR! errno 1
2020-01-14T19:07:48.348561+00:00 app[web.1]: npm ERR! crb-cms@0.1.0 start: `strapi start`
2020-01-14T19:07:48.348964+00:00 app[web.1]: npm ERR! Exit status 1
2020-01-14T19:07:48.349319+00:00 app[web.1]: npm ERR!
2020-01-14T19:07:48.349577+00:00 app[web.1]: npm ERR! Failed at the crb-cms@0.1.0 start script.
2020-01-14T19:07:48.349813+00:00 app[web.1]: npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
2020-01-14T19:07:48.377217+00:00 app[web.1]:
2020-01-14T19:07:48.379481+00:00 app[web.1]: npm ERR! A complete log of this run can be found in:
2020-01-14T19:07:48.379699+00:00 app[web.1]: npm ERR!     /app/.npm/_logs/2020-01-14T19_07_48_351Z-debug.log
2020-01-14T19:07:48.470890+00:00 heroku[web.1]: State changed from starting to crashed
2020-01-14T19:07:48.463204+00:00 heroku[web.1]: Process exited with status 1
2020-01-15T00:45:27.823717+00:00 heroku[web.1]: State changed from crashed to starting
2020-01-15T00:45:39.477158+00:00 heroku[web.1]: Starting process with command `npm start`
2020-01-15T00:45:41.447768+00:00 app[web.1]: [heroku-exec] Starting
2020-01-15T00:45:41.843794+00:00 app[web.1]:
2020-01-15T00:45:41.843809+00:00 app[web.1]: > crb-cms@0.1.0 start /app
2020-01-15T00:45:41.843841+00:00 app[web.1]: > strapi start
2020-01-15T00:45:41.843844+00:00 app[web.1]:
2020-01-15T00:46:14.052031+00:00 app[web.1]: [2020-01-15T00:46:14.051Z] debug ⛔️ Server wasn't able to start properly.
2020-01-15T00:46:14.052949+00:00 app[web.1]: [2020-01-15T00:46:14.052Z] error Error connecting to the Mongo database. Server selection timed out after 30000 ms
2020-01-15T00:46:14.062587+00:00 app[web.1]: npm ERR! code ELIFECYCLE
2020-01-15T00:46:14.062893+00:00 app[web.1]: npm ERR! errno 1
2020-01-15T00:46:14.063795+00:00 app[web.1]: npm ERR! crb-cms@0.1.0 start: `strapi start`
2020-01-15T00:46:14.063901+00:00 app[web.1]: npm ERR! Exit status 1
2020-01-15T00:46:14.064031+00:00 app[web.1]: npm ERR!
2020-01-15T00:46:14.064119+00:00 app[web.1]: npm ERR! Failed at the crb-cms@0.1.0 start script.
2020-01-15T00:46:14.064205+00:00 app[web.1]: npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
2020-01-15T00:46:14.072017+00:00 app[web.1]:
2020-01-15T00:46:14.072185+00:00 app[web.1]: npm ERR! A complete log of this run can be found in:
2020-01-15T00:46:14.072262+00:00 app[web.1]: npm ERR!     /app/.npm/_logs/2020-01-15T00_46_14_064Z-debug.log
2020-01-15T00:46:14.138761+00:00 heroku[web.1]: State changed from starting to crashed
2020-01-15T00:46:14.119514+00:00 heroku[web.1]: Process exited with status 1

Answer 2

[Владислав Бондаренко]

Мне помог этот фикс:
https://github.com/strapi/strapi/pull/6027/commits...