2019-09 / 01 02 03 04 05 06 07 08 09 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30

2019-09-20 (金)

本番環境で heroku run する時の tips [Heroku]

※ 会社の esa.io に投稿した記事の転載です。

本番環境で DB の値を書き換えるために、rails runner や rails console を使うことがある。bash もあるかもしれない。

$ heroku run rails r scripts/important.rb -a <App Name>
# or
$ heroku run rails c -a <App Name>



heroku run のログは現在の端末だけにしか出力されない。アプリのログには出力されないため、LogDNA や Papertrail などにも記録されない。

現在の端末を閉じてしまうと、ログが消失するため十分注意すること。

回避方法


↓ 以下のような非対話型コマンドであれば、run:detached サブコマンドを使うことで、LogDNA などに送ることが出来る。ただし、現在の端末には出力されない。

・rails runner
・ls

↓ 対話型コマンドは今回の方法は使えない。他の回避方法があるかは不明。

・rails console
・bash


非対話型コマンドのログをアプリのログに出力する


※ 以下、<App Name> を immense-shelf-19179 とします。

run:detached サブコマンドと -t オプションを使う。

$ heroku run:detached -t ls -a immense-shelf-19179
Running ls on ⬢ immense-shelf-19179... done, run.7459 (Hobby)
2019-09-18T05:59:42.797129+00:00 heroku[run.7459]: Starting process with command `ls`
2019-09-18T05:59:43.429271+00:00 heroku[run.7459]: State changed from starting to up
2019-09-18T05:59:44.463225+00:00 heroku[run.7459]: State changed from up to complete
2019-09-18T05:59:44.442709+00:00 heroku[run.7459]: Process exited with status 0
2019-09-18T05:59:44.389919+00:00 app[run.7459]: Procfile
2019-09-18T05:59:44.389950+00:00 app[run.7459]: README.md
2019-09-18T05:59:44.389953+00:00 app[run.7459]: app.json
2019-09-18T05:59:44.389955+00:00 app[run.7459]: index.js
(snip)



以下のとおり、run サブコマンドとは出力フォーマットが異なる点には留意する。

$ heroku run ls -a immense-shelf-19179
Running ls on ⬢ immense-shelf-19179... up, run.7702 (Hobby)
Procfile  README.md  app.json  index.js  node_modules  package-lock.json  package.json  public  test.js  views



おまけ


対話型コマンドを run:detached サブコマンドで起動してしまったら


プロンプトが現在の端末に Attach されないため、向こう側で待ち続ける。

↓ よく見ると向こう側で '[1] pry(main)>' が出力されている。

$ heroku run:detached rails c -a immense-shelf-19179
Running rails c on ⬢ immense-shelf-19179... done, run.9514 (Hobby)
Run heroku logs --app immense-shelf-19179 --dyno run.9514 to view the output.

$ heroku logs --app immense-shelf-19179 --dyno run.9514
2019-09-18T06:02:02.544029+00:00 heroku[run.9514]: Starting process with command `rails c`
2019-09-18T06:02:03.329165+00:00 heroku[run.9514]: State changed from starting to up
2019-09-18T06:02:16.615759+00:00 heroku[run.9514]: State changed from up to complete
2019-09-18T06:02:16.557123+00:00 heroku[run.9514]: Process exited with status 0
2019-09-18T06:02:16.213234+00:00 app[run.9514]: Loading staging environment (Rails 5.2.3)
[1] pry(main)>02:16.538739+00:00 app[run.9514]:



今回の場合、run.9514 (One-off) Dyno が待機し続ける。

$ heroku ps -a immense-shelf-19179
=== run: one-off processes (1)
run.9514 (Hobby): up 2019/09/18 15:02:03 +0900 (~ 13s ago): rails c

=== web (Hobby): bundle exec puma -C config/puma.rb (1)
web.1: up 2019/09/18 12:04:41 +0900 (~ 2h ago)



1 時間経つと SIGTERM を受け取り自動終了する。

手動で停止するには ps:kill サブコマンドを使用する。

$ heroku ps:kill run.9514 -a immense-shelf-19179
Stopping run.9514 dyno on ⬢ immense-shelf-19179... done



裏で何が行われているか?


デバッグログを出して、両者を比較すると分かる。

↓ heroku run は、裏で attach_url が発行され、現在の端末に接続されるようだ。

$ DEBUG='*' heroku run ls -a immense-shelf-19179
(snip)
--> {"command":"ls","attach":true,"env":{"TERM":"screen","COLUMNS":165,"LINES":59}}
Running ls on ⬢ immense-shelf-19179... ⢿
<-- 201 Created
  http <-- POST /apps/immense-shelf-19179/dynos
  http {"attach_url":"rendezvous://rendezvous.runtime.heroku.com:5000/e9921dc55fcc6df5d863221874e70f5bef58318a8e785a108f1ff985309c7548","command":"ls","created_at":"2019-09-20T13:01:11Z","id":"0f0bde73-731f-4a52-82df-e84103dc34ab","name":"run.6626","app":{"id":"8b5795a0-98f6-478b-bb13-f53f4ff99e7c","name":"immense-shelf-19179"},"release":{"id":"c8f828c8-942c-40b6-907b-f3e71ff02732","version":3},"size":"Free","state":"starting","type":"run","updated_at":"2019-09-20T13:01:11Z"} +992ms
(snip)



※ rendezvous という URL スキーマを見た感じ、内部的に rendezvous gem を使っているっぽい?(同僚氏談)

↓ heroku run:detached は、attach_url は発行されない。代わりに Logplex 経由で LogDNA 等にログを送るのだと思う。

$ DEBUG='*' heroku run:detached ls -a immense-shelf-19179
(snip)
--> {"command":"ls","attach":false,"env":{"TERM":"screen","COLUMNS":165,"LINES":59}}
Running ls on ⬢ immense-shelf-19179... ⢿
<-- 201 Created
  http <-- POST /apps/immense-shelf-19179/dynos
  http {"attach_url":null,"command":"ls","created_at":"2019-09-20T13:02:22Z","id":"32fddd0d-b8d3-41e6-806e-631cfef1e125","name":"run.6332","app":{"id":"8b5795a0-98f6-478b-bb13-f53f4ff99e7c","name":"immense-shelf-19179"},"release":{"id":"c8f828c8-942c-40b6-907b-f3e71ff02732","version":3},"size":"Free","state":"starting","type":"run","updated_at":"2019-09-20T13:02:22Z"} +1s
(snip)



※ Heroku では Logplex というログルーターが複数の宛先にログを送る。有名な Fluentd もログルーターの一種。

参考情報


One-Off Dynos > Running tasks in background

2019-09 / 01 02 03 04 05 06 07 08 09 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30

最終更新時間: 2019-10-18 15:51 JST

検索


最近の話題
- 2019-10-10
  terraform-provider-healthchecksio を Terraform Plugin SDK に移行した
- 2019-09-20
  本番環境で heroku run する時の tips
- 2019-08-16
  『改訂2版 みんなのGo言語』を読んだ
- 2019-08-13
  『カード決済業務のすべて』を読んだ
  『実行力 結果を出す「仕組み」の作りかた』を読んだ
- 2019-08-05
  Heroku Logging Add-on Papertrail と LogDNA の比較
- 2019-07-16
  ジム通いと食生活改善が 13 ヶ月目に突入した
- 2019-06-10
  esa の記事を Emacs から素早く開ける helm-esa.el を作った
最近追記された記事
- 2019-02-11-1 (25日前)
- 2019-02-03-1 (25日前)
- 2019-01-28-1 (25日前)
- 2019-02-03-1 (67日前)
- 2018-11-28-1 (81日前)
- 2019-05-07-1 (161日前)
- 2018-04-30-1 (176日前)
- 2018-01-28-1 (188日前)
- 2019-02-11-1 (248日前)
- 2019-01-20-1 (266日前)
カテゴリ
- Anthy (3)
- Apache (11)
- Apple (1)
- ATOK (4)
- au (3)
- AWS (23)
- Bazaar (1)
- Berkshelf (2)
- BigQuery (1)
- BitBar (4)
- Book (106)
- Boxen (2)
- Bugsnag (1)
- capistrano (4)
- chalow (57)
- ChatWork (1)
- Chef (17)
- Chrome (3)
- Chromecast (1)
- CircleCI (10)
- clang (26)
- Comics (2)
- Cooking (10)
- cvs (15)
- cygwin (12)
- D3.js (1)
- Debian (55)
- Docker (4)
- E-mail (9)
- elasticsearch (4)
- Emacs (223)
- Emacs講座 (10)
- English (4)
- feedforce (7)
- fetchmail (3)
- Firefox (20)
- Fluentd (4)
- ftp (2)
- Game (21)
- GCP (1)
- Gem (5)
- Git (9)
- GitHub (23)
- golang (11)
- Google (1)
- gpg (4)
- GrowthForecast (7)
- Health (6)
- Heroku (20)
- Homebrew (10)
- HTML (6)
- iBook (1)
- iPad (1)
- iPhone (17)
- IRC (1)
- Jenkins (8)
- JS (1)
- Karabiner (1)
- KeySnail (3)
- Kibana (1)
- Kindle (1)
- Kubernetes (2)
- Langrich (7)
- LDAP (6)
- Life (23)
- Linux (7)
- Mackerel (1)
- macOS (1)
- Mew (18)
- MongoDB (1)
- Mozilla (19)
- Music (1)
- MySQL (1)
- NAS (4)
- nginx (6)
- NHK (1)
- Node (1)
- ntp (4)
- OOP (2)
- OpenID (2)
- openssl (1)
- Opera (2)
- OSX (41)
- Perl (14)
- PHP (19)
- PostgreSQL (1)
- procmail (4)
- Programing (3)
- Puppet (1)
- Python (2)
- Rails (13)
- Rake (2)
- RaspberryPi (2)
- Redash (1)
- RedHat (29)
- Redmine (3)
- RSpec (2)
- Ruby (52)
- samba (3)
- screen (7)
- sed (5)
- serverspec (6)
- sh (8)
- Slack (2)
- Solaris9 (22)
- Spring (2)
- ssh (4)
- StatusNet (21)
- svn (12)
- Swift (1)
- Tablet (1)
- tdiary (3)
- Terraform (2)
- Twitter (15)
- Twmode (6)
- Ubuntu (5)
- UNIX (102)
- vagrant (8)
- Video (21)
- vim (1)
- Wercker (9)
- Windows (29)
- Wine (3)
- XML (11)
- XP (1)
- zsh (26)
- インストールメモ (33)
- クイックシェイプ (12)
- ネタ (15)
- 勉強会 (17)
- 携帯 (6)
- 正規表現 (4)
過去ログ
2019 : 01 02 03 04 05 06 07 08 09 10 11 12
2018 : 01 02 03 04 05 06 07 08 09 10 11 12
2017 : 01 02 03 04 05 06 07 08 09 10 11 12
2016 : 01 02 03 04 05 06 07 08 09 10 11 12
2015 : 01 02 03 04 05 06 07 08 09 10 11 12
2014 : 01 02 03 04 05 06 07 08 09 10 11 12
2013 : 01 02 03 04 05 06 07 08 09 10 11 12
2012 : 01 02 03 04 05 06 07 08 09 10 11 12
2011 : 01 02 03 04 05 06 07 08 09 10 11 12
2010 : 01 02 03 04 05 06 07 08 09 10 11 12
2009 : 01 02 03 04 05 06 07 08 09 10 11 12
2008 : 01 02 03 04 05 06 07 08 09 10 11 12
2007 : 01 02 03 04 05 06 07 08 09 10 11 12
2006 : 01 02 03 04 05 06 07 08 09 10 11 12
2005 : 01 02 03 04 05 06 07 08 09 10 11 12
2004 : 01 02 03 04 05 06 07 08 09 10 11 12
2003 : 01 02 03 04 05 06 07 08 09 10 11 12
2002 : 01 02 03 04 05 06 07 08 09 10 11 12
2001 : 01 02 03 04 05 06 07 08 09 10 11 12