AgileVentures / WebsiteOne

A website for Agile Ventures
https://www.agileventures.org
Other
143 stars 248 forks source link

trouble with automated PR deploys #1348

Closed tansaku closed 8 years ago

tansaku commented 8 years ago
FATAL:  permission denied for database "postgres"
DETAIL:  User does not have CONNECT privilege.
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `initialize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `new'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `connect'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:242:in `initialize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:44:in `new'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:44:in `postgresql_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:438:in `new_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:448:in `checkout_new_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:422:in `acquire_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:349:in `block in checkout'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:348:in `checkout'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:263:in `block in connection'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:262:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:571:in `retrieve_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_handling.rb:113:in `retrieve_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_handling.rb:87:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/postgresql_database_tasks.rb:6:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/postgresql_database_tasks.rb:15:in `create'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:93:in `create'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:107:in `block in create_current'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:275:in `block in each_current_configuration'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:274:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:274:in `each_current_configuration'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:106:in `create_current'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/railties/databases.rake:17:in `block (2 levels) in <top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:248:in `block in execute'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:243:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:243:in `execute'
/app/vendor/bundle/ruby/2.3.0/gems/airbrake-5.4.1/lib/airbrake/rake/task_ext.rb:19:in `execute'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:187:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:209:in `block in invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:186:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:209:in `block in invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:186:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:173:in `invoke'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:150:in `invoke_task'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `block (2 levels) in top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `block in top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:115:in `run_with_threads'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:100:in `top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:78:in `block in run'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:176:in `standard_exception_handling'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:75:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/bin/rake:33:in `<top (required)>'
/app/vendor/bundle/ruby/2.3.0/bin/rake:23:in `load'
/app/vendor/bundle/ruby/2.3.0/bin/rake:23:in `<top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:74:in `load'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:74:in `kernel_load'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:27:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:332:in `exec'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/command.rb:27:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/invocation.rb:126:in `invoke_command'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor.rb:359:in `dispatch'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:20:in `dispatch'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/base.rb:440:in `start'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:11:in `start'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/exe/bundle:34:in `block in <top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/friendly_errors.rb:100:in `with_friendly_errors'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/exe/bundle:26:in `<top (required)>'
/app/bin/bundle:3:in `load'
/app/bin/bundle:3:in `<main>'
Couldn't create database for {"adapter"=>"postgresql", "encoding"=>"unicode", "database"=>"....", "pool"=>20, "username"=>"...", "password"=>"....", "port"=>5432, "host"=>"ec2-79-125-9-43.eu-west-1.compute.amazonaws.com"}
-- enable_extension("plpgsql")
   -> 0.0384s
-- enable_extension("pg_stat_statements")
   -> 0.0144s
-- create_table("activities", {:force=>:cascade})
   -> 0.0149s
-- add_index("activities", ["owner_id", "owner_type"], {:name=>"index_activities_on_owner_id_and_owner_type", :using=>:btree})
   -> 0.0147s
-- add_index("activities", ["recipient_id", "recipient_type"], {:name=>"index_activities_on_recipient_id_and_recipient_type", :using=>:btree})
   -> 0.0187s
-- add_index("activities", ["trackable_id", "trackable_type"], {:name=>"index_activities_on_trackable_id_and_trackable_type", :using=>:btree})
   -> 0.0119s
-- create_table("articles", {:force=>:cascade})
   -> 0.0170s
-- add_index("articles", ["slug"], {:name=>"index_articles_on_slug", :unique=>true, :using=>:btree})
   -> 0.0277s
-- add_index("articles", ["title"], {:name=>"index_articles_on_title", :using=>:btree})
   -> 0.0198s
-- add_index("articles", ["user_id"], {:name=>"index_articles_on_user_id", :using=>:btree})
   -> 0.0148s
-- create_table("authentications", {:force=>:cascade})
   -> 0.0127s
-- add_index("authentications", ["user_id"], {:name=>"index_authentications_on_user_id", :using=>:btree})
   -> 0.0080s
-- create_table("commit_counts", {:force=>:cascade})
   -> 0.0110s
-- add_index("commit_counts", ["project_id"], {:name=>"index_commit_counts_on_project_id", :using=>:btree})
   -> 0.0056s
-- add_index("commit_counts", ["user_id"], {:name=>"index_commit_counts_on_user_id", :using=>:btree})
   -> 0.0065s
-- create_table("documents", {:force=>:cascade})
   -> 0.0095s
-- add_index("documents", ["project_id"], {:name=>"index_documents_on_project_id", :using=>:btree})
   -> 0.0053s
-- add_index("documents", ["slug", "user_id"], {:name=>"index_documents_on_slug_and_user_id", :unique=>true, :using=>:btree})
   -> 0.0075s
-- add_index("documents", ["user_id"], {:name=>"index_documents_on_user_id", :using=>:btree})
   -> 0.0057s
-- create_table("event_instances", {:force=>:cascade})
   -> 0.0089s
-- create_table("events", {:force=>:cascade})
   -> 0.0100s
-- add_index("events", ["slug"], {:name=>"index_events_on_slug", :unique=>true, :using=>:btree})
   -> 0.0054s
-- add_index("events", ["start_datetime"], {:name=>"index_events_on_start_datetime", :using=>:btree})
   -> 0.0053s
-- create_table("follows", {:force=>:cascade})
   -> 0.0111s
-- add_index("follows", ["followable_id", "followable_type"], {:name=>"fk_followables", :using=>:btree})
   -> 0.0052s
-- add_index("follows", ["follower_id", "follower_type"], {:name=>"fk_follows", :using=>:btree})
   -> 0.0050s
-- create_table("hangout_participants_snapshots", {:force=>:cascade})
   -> 0.0140s
-- create_table("karmas", {:force=>:cascade})
   -> 0.0074s
-- create_table("newsletters", {:force=>:cascade})
   -> 0.0101s
-- create_table("payment_sources", {:force=>:cascade})
   -> 0.0084s
-- create_table("projects", {:force=>:cascade})
   -> 0.0096s
-- add_index("projects", ["slug"], {:name=>"index_projects_on_slug", :unique=>true, :using=>:btree})
   -> 0.0055s
-- add_index("projects", ["user_id"], {:name=>"index_projects_on_user_id", :using=>:btree})
   -> 0.0062s
-- create_table("static_pages", {:force=>:cascade})
   -> 0.0083s
-- add_index("static_pages", ["slug"], {:name=>"index_static_pages_on_slug", :unique=>true, :using=>:btree})
   -> 0.0056s
-- create_table("statuses", {:force=>:cascade})
   -> 0.0056s
-- create_table("subscriptions", {:force=>:cascade})
   -> 0.0083s
-- create_table("taggings", {:force=>:cascade})
   -> 0.0084s
-- add_index("taggings", ["tag_id", "taggable_id", "taggable_type", "context", "tagger_id", "tagger_type"], {:name=>"taggings_idx", :unique=>true, :using=>:btree})
   -> 0.0061s
-- add_index("taggings", ["taggable_id", "taggable_type", "context"], {:name=>"index_taggings_on_taggable_id_and_taggable_type_and_context", :using=>:btree})
   -> 0.0125s
-- add_index("taggings", ["tagger_id"], {:name=>"index_taggings_on_tagger_id", :using=>:btree})
   -> 0.0055s
-- add_index("taggings", ["tagger_type"], {:name=>"index_taggings_on_tagger_type", :using=>:btree})
   -> 0.0052s
-- create_table("tags", {:force=>:cascade})
   -> 0.0062s
-- add_index("tags", ["name"], {:name=>"index_tags_on_name", :unique=>true, :using=>:btree})
   -> 0.0052s
-- create_table("users", {:force=>:cascade})
   -> 0.0138s
-- add_index("users", ["email"], {:name=>"index_users_on_email", :unique=>true, :using=>:btree})
   -> 0.0052s
-- add_index("users", ["reset_password_token"], {:name=>"index_users_on_reset_password_token", :unique=>true, :using=>:btree})
   -> 0.0054s
-- add_index("users", ["slug"], {:name=>"index_users_on_slug", :unique=>true, :using=>:btree})
   -> 0.0077s
-- create_table("versions", {:force=>:cascade})
   -> 0.0082s
-- add_index("versions", ["item_type", "item_id"], {:name=>"index_versions_on_item_type_and_item_id", :using=>:btree})
   -> 0.0076s
-- create_table("votes", {:force=>:cascade})
   -> 0.0083s
-- add_index("votes", ["votable_id", "votable_type", "vote_scope"], {:name=>"index_votes_on_votable_id_and_votable_type_and_vote_scope", :using=>:btree})
   -> 0.0059s
-- add_index("votes", ["voter_id", "voter_type", "vote_scope"], {:name=>"index_votes_on_voter_id_and_voter_type_and_vote_scope", :using=>:btree})
   -> 0.0053s
-- add_foreign_key("events", "users", {:column=>"creator_id"})
   -> 0.0036s
-- initialize_schema_migrations_table()
   -> 0.0210s
Clearing existing projects and documents
Added default user with email: random@random.com and password: randomrandom
Created default projects
[ActiveJob] [ActionMailer::DeliveryJob] [eadacff4-bcd2-4195-8bc2-7c3bc8102bbf] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "random@random.com", nil, "already_invited"
[ActiveJob] [ActionMailer::DeliveryJob] [eadacff4-bcd2-4195-8bc2-7c3bc8102bbf]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (1.9ms)
[ActiveJob] [ActionMailer::DeliveryJob] [eadacff4-bcd2-4195-8bc2-7c3bc8102bbf] 
Sent mail to support@agileventures.org (1154.1ms)
[ActiveJob] [ActionMailer::DeliveryJob] [eadacff4-bcd2-4195-8bc2-7c3bc8102bbf] Performed ActionMailer::DeliveryJob from Inline(mailers) in 1366.83ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: eadacff4-bcd2-4195-8bc2-7c3bc8102bbf) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "random@random.com", nil, "already_invited"
Created Static Page: Berkeley Fall 2012 Projects
Created Static Page: Cs Degree Online
Created Static Page: Pair
Created Static Page: About Us
Created Static Page: Grow
Created Static Page: Saas Ells Screencasts
Created Static Page: Sponsors
Created Static Page: Ubuntu Bash Help
Created Static Page: Guides
Created Static Page: Sortable Ells Errata
Created Static Page: Code
Created Static Page: Learn1
Created Static Page: Remote Pair Programming
Created Static Page: Getting Started
Created Static Page: Personal Tuition Service
Created Static Page: Remote Pair Programming/Example Videos
Created Static Page: Remote Pair Programming/Pair Programming Calendar
Created Static Page: Remote Pair Programming/Pair Programming Form
Created Static Page: Remote Pair Programming/C9 Howto
Created Static Page: Remote Pair Programming/Pair Programming Protocols
Created Static Page: Remote Pair Programming/Pair Programming Help Videos
Created Static Page: Remote Pair Programming/Creating A Pp Event On G
Created Static Page: Remote Pair Programming/Gnu Screen Pairing Notes
Created Static Page: Remote Pair Programming/Analysis
Created Static Page: Remote Pair Programming/Pair Programming Protocols/Classroom Guidelines
Created Static Page: Remote Pair Programming/Pair Programming Protocols/Github Pong
Project.count 0 -> 9
Document.count 0 -> 16
User.count 0 -> 301
Article.count 0 -> 12
Event.count 0 -> 2
Queued jobs didn't finish before shutdown_timeout...killing remaining jobs
[ActiveJob] [ActionMailer::DeliveryJob] [357acdc2-bfc1-4458-bc6f-40edb877767d] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "helmer@conroy.info", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [357acdc2-bfc1-4458-bc6f-40edb877767d]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (0.1ms)
[ActiveJob] [ActionMailer::DeliveryJob] [35699625-9ce1-425e-9018-0884a58b8ce1] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "neva_monahan@swaniawskilemke.name", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [35699625-9ce1-425e-9018-0884a58b8ce1]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (0.1ms)
[ActiveJob] [ActionMailer::DeliveryJob] [35699625-9ce1-425e-9018-0884a58b8ce1] 
Sent mail to support@agileventures.org (233.1ms)
[ActiveJob] [ActionMailer::DeliveryJob] [35699625-9ce1-425e-9018-0884a58b8ce1] Performed ActionMailer::DeliveryJob from Inline(mailers) in 235.79ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 35699625-9ce1-425e-9018-0884a58b8ce1) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "neva_monahan@swaniawskilemke.name", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [357acdc2-bfc1-4458-bc6f-40edb877767d] 
Sent mail to support@agileventures.org (260.0ms)
[ActiveJob] [ActionMailer::DeliveryJob] [357acdc2-bfc1-4458-bc6f-40edb877767d] Performed ActionMailer::DeliveryJob from Inline(mailers) in 266.51ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 357acdc2-bfc1-4458-bc6f-40edb877767d) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "helmer@conroy.info", nil, nil

which I think relates to some emails that are leaking out of tests - something to do with db:seed ...

tansaku commented 8 years ago

we had same issue on LS at one point: https://www.pivotaltracker.com/story/show/116276111

tansaku commented 8 years ago

this was what Heroku was saying about that kind of problem before:

There is a caveat when building review apps that we have requested a new database addon, but it's not guaranteed to be provisioned during the build phase. It sounds like something in your application is trying to access the database before your database is up and ready to receive connections.

The ideal fix is to track down why the app is connecting to the database during build and try to prevent that. If that's not an option, we also have a buildpack that you can use to wait for your database to come up: https://github.com/heroku/heroku-buildpack-addon-wait.

tansaku commented 8 years ago

okay, so I tried a PR with a slightly modified app.json, and the logs now show that the migration is running - then that we can't connect to the DB, then it loads the schema, both apparently successfully in contradiction to the suggestion that we can't connect to the DB, and then we get emails sent out about our failing slack invites:

Migrating to DeviseCreateUsers (20140109040839)
== 20140109040839 DeviseCreateUsers: migrating ================================
-- create_table(:users)
   -> 0.0128s
-- add_index(:users, :email, {:unique=>true})
   -> 0.0052s
-- add_index(:users, :reset_password_token, {:unique=>true})
   -> 0.0050s
== 20140109040839 DeviseCreateUsers: migrated (0.0233s) =======================

Migrating to CreateProjects (20140110123347)
== 20140110123347 CreateProjects: migrating ===================================
-- create_table(:projects)
   -> 0.0065s
== 20140110123347 CreateProjects: migrated (0.0067s) ==========================

Migrating to CreateDocuments (20140116112830)
== 20140116112830 CreateDocuments: migrating ==================================
-- create_table(:documents)
   -> 0.0061s
== 20140116112830 CreateDocuments: migrated (0.0062s) =========================

Migrating to ChangeProjectsAttributes (20140118045711)
== 20140118045711 ChangeProjectsAttributes: migrating =========================
-- change_table(:projects)
   -> 0.0018s
== 20140118045711 ChangeProjectsAttributes: migrated (0.0019s) ================

Migrating to AddFirstLastNamesToUsers (20140120014041)
== 20140120014041 AddFirstLastNamesToUsers: migrating =========================
-- add_column(:users, :first_name, :string)
   -> 0.0018s
-- add_column(:users, :last_name, :string)
   -> 0.0010s
== 20140120014041 AddFirstLastNamesToUsers: migrated (0.0031s) ================

Migrating to AddParentIdToDocuments (20140124205750)
== 20140124205750 AddParentIdToDocuments: migrating ===========================
-- add_column(:documents, :parent_id, :integer)
   -> 0.0019s
== 20140124205750 AddParentIdToDocuments: migrated (0.0021s) ==================

Migrating to CreateAuthentications (20140124213333)
== 20140124213333 CreateAuthentications: migrating ============================
-- create_table(:authentications)
   -> 0.0085s
-- add_index(:authentications, :user_id)
   -> 0.0055s
== 20140124213333 CreateAuthentications: migrated (0.0142s) ===================

Migrating to ActsAsFollowerMigration (20140127043432)
== 20140127043432 ActsAsFollowerMigration: migrating ==========================
-- create_table(:follows, {:force=>true})
   -> 0.0095s
-- add_index(:follows, ["follower_id", "follower_type"], {:name=>"fk_follows"})
   -> 0.0052s
-- add_index(:follows, ["followable_id", "followable_type"], {:name=>"fk_followables"})
   -> 0.0054s
== 20140127043432 ActsAsFollowerMigration: migrated (0.0204s) =================

Migrating to AddCreatedByToDocuments (20140130073721)
== 20140130073721 AddCreatedByToDocuments: migrating ==========================
-- add_column(:documents, :user_id, :integer)
   -> 0.0019s
-- add_index(:documents, :user_id)
   -> 0.0062s
== 20140130073721 AddCreatedByToDocuments: migrated (0.0083s) =================

Migrating to AddCreatedByToProjects (20140130073828)
== 20140130073828 AddCreatedByToProjects: migrating ===========================
-- add_column(:projects, :user_id, :integer)
   -> 0.0018s
-- add_index(:projects, :user_id)
   -> 0.0054s
== 20140130073828 AddCreatedByToProjects: migrated (0.0074s) ==================

Migrating to AddDisplayEmailToUsers (20140207004506)
== 20140207004506 AddDisplayEmailToUsers: migrating ===========================
-- add_column(:users, :display_email, :boolean)
   -> 0.0019s
== 20140207004506 AddDisplayEmailToUsers: migrated (0.0020s) ==================

Migrating to AddYouTubeIdToUser (20140207033343)
== 20140207033343 AddYouTubeIdToUser: migrating ===============================
-- add_column(:users, :youtube_id, :string)
   -> 0.0017s
== 20140207033343 AddYouTubeIdToUser: migrated (0.0018s) ======================

Migrating to AddSlugsToModels (20140207190458)
== 20140207190458 AddSlugsToModels: migrating =================================
-- add_column(:users, :slug, :string)
   -> 0.0019s
-- add_index(:users, :slug, {:unique=>true})
   -> 0.0094s
-- add_column(:projects, :slug, :string)
   -> 0.0010s
-- add_index(:projects, :slug, {:unique=>true})
   -> 0.0067s
-- add_column(:documents, :slug, :string)
   -> 0.0010s
-- add_index(:documents, :slug, {:unique=>true})
   -> 0.0054s
== 20140207190458 AddSlugsToModels: migrated (0.0261s) ========================

Migrating to AddDisplayProfileToUsers (20140209164254)
== 20140209164254 AddDisplayProfileToUsers: migrating =========================
-- add_column(:users, :display_profile, :boolean, {:default=>true})
   -> 0.0137s
== 20140209164254 AddDisplayProfileToUsers: migrated (0.0143s) ================

Migrating to ActsAsTaggableOnMigration (20140215192014)
== 20140215192014 ActsAsTaggableOnMigration: migrating ========================
-- create_table(:tags)
   -> 0.0062s
-- create_table(:taggings)
   -> 0.0060s
-- add_index(:taggings, :tag_id)
   -> 0.0053s
-- add_index(:taggings, [:taggable_id, :taggable_type, :context])
   -> 0.0051s
== 20140215192014 ActsAsTaggableOnMigration: migrated (0.0230s) ===============

Migrating to CreateArticles (20140219145424)
== 20140219145424 CreateArticles: migrating ===================================
-- create_table(:articles)
   -> 0.0062s
-- add_index(:articles, :title)
   -> 0.0053s
-- add_index(:articles, :slug, {:unique=>true})
   -> 0.0049s
== 20140219145424 CreateArticles: migrated (0.0167s) ==========================

Migrating to AddLatitudeAndLongitudeToUser (20140220091703)
== 20140220091703 AddLatitudeAndLongitudeToUser: migrating ====================
-- add_column(:users, :latitude, :float)
   -> 0.0017s
-- add_column(:users, :longitude, :float)
   -> 0.0010s
== 20140220091703 AddLatitudeAndLongitudeToUser: migrated (0.0028s) ===========

Migrating to AddCountryRegionCityToUser (20140220131347)
== 20140220131347 AddCountryRegionCityToUser: migrating =======================
-- add_column(:users, :country, :string)
   -> 0.0017s
-- add_column(:users, :city, :string)
   -> 0.0010s
-- add_column(:users, :region, :string)
   -> 0.0010s
== 20140220131347 AddCountryRegionCityToUser: migrated (0.0039s) ==============

Migrating to CreateVersions (20140225000044)
== 20140225000044 CreateVersions: migrating ===================================
-- create_table(:versions)
   -> 0.0067s
-- add_index(:versions, [:item_type, :item_id])
   -> 0.0055s
== 20140225000044 CreateVersions: migrated (0.0124s) ==========================

Migrating to CreateEvents (20140225215805)
== 20140225215805 CreateEvents: migrating =====================================
-- create_table(:events)
   -> 0.0078s
== 20140225215805 CreateEvents: migrated (0.0080s) ============================

Migrating to AddYoutubeUserNameToUser (20140304210808)
== 20140304210808 AddYoutubeUserNameToUser: migrating =========================
-- add_column(:users, :youtube_user_name, :string)
   -> 0.0017s
== 20140304210808 AddYoutubeUserNameToUser: migrated (0.0018s) ================

Migrating to AddCurrentHoaUrlToEvents (20140305125426)
== 20140305125426 AddCurrentHoaUrlToEvents: migrating =========================
-- add_column(:events, :url, :string)
   -> 0.0017s
== 20140305125426 AddCurrentHoaUrlToEvents: migrated (0.0018s) ================

Migrating to AddGithubProfileUrl (20140309133549)
== 20140309133549 AddGithubProfileUrl: migrating ==============================
-- add_column(:users, :github_profile_url, :string)
   -> 0.0018s
== 20140309133549 AddGithubProfileUrl: migrated (0.0020s) =====================

Migrating to AddPivotaltrackerIdToProjects (20140311052222)
== 20140311052222 AddPivotaltrackerIdToProjects: migrating ====================
-- add_column(:projects, :pivotaltracker_id, :integer)
   -> 0.0017s
== 20140311052222 AddPivotaltrackerIdToProjects: migrated (0.0018s) ===========

Migrating to ReplaceDocumentIndex (20140313161712)
== 20140313161712 ReplaceDocumentIndex: migrating =============================
-- remove_index(:documents, :slug)
   -> 0.0024s
-- add_index(:documents, [:slug, :user_id], {:unique=>true})
   -> 0.0052s
== 20140313161712 ReplaceDocumentIndex: migrated (0.0077s) ====================

Migrating to AddDisplayHireMeToUsers (20140317093616)
== 20140317093616 AddDisplayHireMeToUsers: migrating ==========================
-- add_column(:users, :display_hire_me, :boolean)
   -> 0.0018s
== 20140317093616 AddDisplayHireMeToUsers: migrated (0.0019s) =================

Migrating to AddBioToUsers (20140319173130)
== 20140319173130 AddBioToUsers: migrating ====================================
-- add_column(:users, :bio, :text)
   -> 0.0017s
== 20140319173130 AddBioToUsers: migrated (0.0018s) ===========================

Migrating to CreatePages (20140322120003)
== 20140322120003 CreatePages: migrating ======================================
-- create_table(:static_pages)
   -> 0.0072s
-- add_index(:static_pages, :slug, {:unique=>true})
   -> 0.0057s
== 20140322120003 CreatePages: migrated (0.0132s) =============================

Migrating to AddGithubUrlToProjects (20140324210924)
== 20140324210924 AddGithubUrlToProjects: migrating ===========================
-- add_column(:projects, :github_url, :string)
   -> 0.0020s
== 20140324210924 AddGithubUrlToProjects: migrated (0.0022s) ==================

Migrating to AddPivotaltrackerUrlToProjects (20140324211134)
== 20140324211134 AddPivotaltrackerUrlToProjects: migrating ===================
-- add_column(:projects, :pivotaltracker_url, :string)
   -> 0.0017s
== 20140324211134 AddPivotaltrackerUrlToProjects: migrated (0.0018s) ==========

Migrating to AddSlugToEvents (20140402091353)
== 20140402091353 AddSlugToEvents: migrating ==================================
-- add_column(:events, :slug, :string)
   -> 0.0023s
-- add_index(:events, :slug, {:unique=>true})
   -> 0.0055s
== 20140402091353 AddSlugToEvents: migrated (0.0084s) =========================

Migrating to RemovePivotaltrackerIdFromProjects (20140404100037)
== 20140404100037 RemovePivotaltrackerIdFromProjects: migrating ===============
-- remove_column(:projects, :pivotaltracker_id)
   -> 0.0010s
== 20140404100037 RemovePivotaltrackerIdFromProjects: migrated (0.0012s) ======

Migrating to AddEmailOptionToUser (20140414125301)
== 20140414125301 AddEmailOptionToUser: migrating =============================
-- add_column(:users, :receive_mailings, :boolean, {:default=>true})
   -> 0.0136s
== 20140414125301 AddEmailOptionToUser: migrated (0.0138s) ====================

Migrating to ActsAsVotableMigration (20140417124942)
== 20140417124942 ActsAsVotableMigration: migrating ===========================
-- create_table(:votes)
   -> 0.0070s
-- add_index(:votes, [:voter_id, :voter_type, :vote_scope])
   -> 0.0057s
-- add_index(:votes, [:votable_id, :votable_type, :vote_scope])
   -> 0.0054s
== 20140417124942 ActsAsVotableMigration: migrated (0.0183s) ==================

Migrating to AddMissingUniqueIndices (20140427074629)
== 20140427074629 AddMissingUniqueIndices: migrating ==========================
-- add_index(:tags, :name, {:unique=>true})
   -> 0.0055s
-- remove_index(:taggings, :tag_id)
   -> 0.0025s
-- remove_index(:taggings, [:taggable_id, :taggable_type, :context])
   -> 0.0026s
-- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {:unique=>true, :name=>"taggings_idx"})
   -> 0.0065s
== 20140427074629 AddMissingUniqueIndices: migrated (0.0178s) =================

Migrating to AddTaggingsCounterCacheToTags (20140427074630)
== 20140427074630 AddTaggingsCounterCacheToTags: migrating ====================
-- add_column(:tags, :taggings_count, :integer, {:default=>0})
   -> 0.0101s
== 20140427074630 AddTaggingsCounterCacheToTags: migrated (0.0245s) ===========

Migrating to AddKarmaToUsers (20140525135633)
== 20140525135633 AddKarmaToUsers: migrating ==================================
-- add_column(:users, :karma_points, :integer, {:default=>0})
   -> 0.0215s
== 20140525135633 AddKarmaToUsers: migrated (0.0216s) =========================

Migrating to CreateHangouts (20140606204845)
== 20140606204845 CreateHangouts: migrating ===================================
-- create_table(:hangouts)
   -> 0.0075s
== 20140606204845 CreateHangouts: migrated (0.0076s) ==========================

Migrating to AddIndexesForReferences (20140615154859)
== 20140615154859 AddIndexesForReferences: migrating ==========================
-- add_index(:articles, :user_id)
   -> 0.0053s
-- add_index(:documents, :project_id)
   -> 0.0052s
-- add_index(:taggings, :tagger_id)
   -> 0.0052s
-- add_index(:taggings, :tagger_type)
   -> 0.0051s
== 20140615154859 AddIndexesForReferences: migrated (0.0212s) =================

Migrating to CreateCommitCounts (20140618153610)
== 20140618153610 CreateCommitCounts: migrating ===============================
-- create_table(:commit_counts)
   -> 0.0151s
== 20140618153610 CreateCommitCounts: migrated (0.0152s) ======================

Migrating to AddCategoryToHangout (20140707211758)
== 20140707211758 AddCategoryToHangout: migrating =============================
-- add_column(:hangouts, :uid, :string)
   -> 0.0017s
-- add_column(:hangouts, :category, :string)
   -> 0.0010s
== 20140707211758 AddCategoryToHangout: migrated (0.0029s) ====================

Migrating to ImportGettingStartedStaticPage (20140716134701)
== 20140716134701 ImportGettingStartedStaticPage: migrating ===================
Imported Getting_started static page
== 20140716134701 ImportGettingStartedStaticPage: migrated (0.1658s) ==========

Migrating to EventCombineDateAndTimeFields (20140725131327)
== 20140725131327 EventCombineDateAndTimeFields: migrating ====================
-- add_column(:events, :start_datetime, :datetime)
   -> 0.0059s
-- add_index(:events, :start_datetime)
   -> 0.0061s
-- add_column(:events, :duration, :integer)
   -> 0.0010s
-- remove_column(:events, :start_time, :time)
   -> 0.0010s
-- remove_column(:events, :event_date, :date)
   -> 0.0010s
-- remove_column(:events, :end_time, :time)
   -> 0.0009s
== 20140725131327 EventCombineDateAndTimeFields: migrated (0.0304s) ===========

Migrating to AddProjectAndHostToHangout (20140730123120)
== 20140730123120 AddProjectAndHostToHangout: migrating =======================
-- add_column(:hangouts, :project_id, :integer)
   -> 0.0017s
-- add_column(:hangouts, :user_id, :integer)
   -> 0.0010s
-- add_column(:hangouts, :yt_video_id, :string)
   -> 0.0009s
-- add_column(:hangouts, :participants, :text)
   -> 0.0010s
== 20140730123120 AddProjectAndHostToHangout: migrated (0.0049s) ==============

Migrating to AddExclusionsToEvents (20140910225619)
== 20140910225619 AddExclusionsToEvents: migrating ============================
-- add_column(:events, :exclusions, :text)
   -> 0.0017s
== 20140910225619 AddExclusionsToEvents: migrated (0.0018s) ===================

Migrating to AddPitchToProjects (20140913021637)
== 20140913021637 AddPitchToProjects: migrating ===============================
-- add_column(:projects, :pitch, :string)
   -> 0.0020s
== 20140913021637 AddPitchToProjects: migrated (0.0022s) ======================

Migrating to ChangeColumn (20140913183322)
== 20140913183322 ChangeColumn: migrating =====================================
-- change_column(:projects, :pitch, :text)
   -> 0.0019s
== 20140913183322 ChangeColumn: migrated (0.0020s) ============================

Migrating to CreateActivities (20140914202645)
== 20140914202645 CreateActivities: migrating =================================
-- create_table(:activities)
   -> 0.0074s
-- add_index(:activities, [:trackable_id, :trackable_type])
   -> 0.0055s
-- add_index(:activities, [:owner_id, :owner_type])
   -> 0.0052s
-- add_index(:activities, [:recipient_id, :recipient_type])
   -> 0.0054s
== 20140914202645 CreateActivities: migrated (0.0238s) ========================

Migrating to RenameHangoutsToEventInstances (20140917070939)
== 20140917070939 RenameHangoutsToEventInstances: migrating ===================
-- rename_table(:hangouts, :event_instances)
   -> 0.0073s
== 20140917070939 RenameHangoutsToEventInstances: migrated (0.0074s) ==========

Migrating to CreateStatuses (20140929201012)
== 20140929201012 CreateStatuses: migrating ===================================
-- create_table(:statuses)
   -> 0.0065s
== 20140929201012 CreateStatuses: migrated (0.0066s) ==========================

Migrating to CreateNewsletters (20141002084933)
== 20141002084933 CreateNewsletters: migrating ================================
-- create_table(:newsletters)
   -> 0.0143s
== 20141002084933 CreateNewsletters: migrated (0.0144s) =======================

Migrating to AddCommitCountToProjects (20141007192312)
== 20141007192312 AddCommitCountToProjects: migrating =========================
-- add_column(:projects, :commit_count, :integer, {:default=>0})
   -> 0.0190s
== 20141007192312 AddCommitCountToProjects: migrated (0.0191s) ================

Migrating to AddAttributesToUsers (20141013191112)
== 20141013191112 AddAttributesToUsers: migrating =============================
-- add_column(:users, :country_code, :string)
   -> 0.0019s
-- rename_column(:users, :country, :country_name)
   -> 0.0056s
== 20141013191112 AddAttributesToUsers: migrated (0.0076s) ====================

Migrating to AddImageUrlToProjects (20141119002743)
== 20141119002743 AddImageUrlToProjects: migrating ============================
-- add_column(:projects, :image_url, :string)
   -> 0.0018s
== 20141119002743 AddImageUrlToProjects: migrated (0.0019s) ===================

Migrating to AddTimezoneOffsetToUsers (20150208124239)
== 20150208124239 AddTimezoneOffsetToUsers: migrating =========================
-- add_column(:users, :timezone_offset, :integer)
   -> 0.0017s
== 20150208124239 AddTimezoneOffsetToUsers: migrated (0.0019s) ================

Migrating to AddMissingTaggableIndex (20150308085306)
== 20150308085306 AddMissingTaggableIndex: migrating ==========================
-- add_index(:taggings, [:taggable_id, :taggable_type, :context])
   -> 0.0058s
== 20150308085306 AddMissingTaggableIndex: migrated (0.0059s) =================

Migrating to ChangeCollationForTagNames (20150308085307)
== 20150308085307 ChangeCollationForTagNames: migrating =======================
== 20150308085307 ChangeCollationForTagNames: migrated (0.0001s) ==============

Migrating to AddStatusCountToUsers (20150410173625)
== 20150410173625 AddStatusCountToUsers: migrating ============================
-- add_column(:users, :status_count, :integer, {:default=>0})
   -> 0.0161s
== 20150410173625 AddStatusCountToUsers: migrated (0.0225s) ===================

Migrating to AddHoaStatusToEventInstances (20150520184236)
== 20150520184236 AddHoaStatusToEventInstances: migrating =====================
-- add_column(:event_instances, :hoa_status, :string)
   -> 0.0018s
== 20150520184236 AddHoaStatusToEventInstances: migrated (0.0129s) ============

Migrating to AddProjectToEvents (20160316153919)
== 20160316153919 AddProjectToEvents: migrating ===============================
-- add_reference(:events, :project)
   -> 0.0019s
== 20160316153919 AddProjectToEvents: migrated (0.0020s) ======================

Migrating to AddCreatorToEvents (20160627134611)
== 20160627134611 AddCreatorToEvents: migrating ===============================
-- add_column(:events, :creator_id, :integer, {:index=>true})
   -> 0.0017s
-- add_foreign_key(:events, :users, {:column=>:creator_id})
   -> 0.0025s
== 20160627134611 AddCreatorToEvents: migrated (0.0044s) ======================

Migrating to AddStripeCustomerIDtoUsers (20160831131548)
== 20160831131548 AddStripeCustomerIDtoUsers: migrating =======================
-- add_column(:users, :stripe_customer, :string)
   -> 0.0018s
== 20160831131548 AddStripeCustomerIDtoUsers: migrated (0.0019s) ==============

Migrating to CreateKarmas (20160921152810)
== 20160921152810 CreateKarmas: migrating =====================================
-- create_table(:karmas)
   -> 0.0067s
== 20160921152810 CreateKarmas: migrated (0.0068s) ============================

Migrating to RemoveKarmaFromUserTable (20160928132707)
== 20160928132707 RemoveKarmaFromUserTable: migrating =========================
-- remove_column(:users, :karma_points, :integer)
   -> 0.0011s
== 20160928132707 RemoveKarmaFromUserTable: migrated (0.0012s) ================

Migrating to RenameKarmaKarmaToTotal (20160928134250)
== 20160928134250 RenameKarmaKarmaToTotal: migrating ==========================
-- rename_column(:karmas, :karma, :total)
   -> 0.0031s
== 20160928134250 RenameKarmaKarmaToTotal: migrated (0.0032s) =================

Migrating to AddHangoutParticipantsSnapshots (20160928152822)
== 20160928152822 AddHangoutParticipantsSnapshots: migrating ==================
-- create_table(:hangout_participants_snapshots)
   -> 0.0063s
== 20160928152822 AddHangoutParticipantsSnapshots: migrated (0.0064s) =========

FATAL:  permission denied for database "postgres"
DETAIL:  User does not have CONNECT privilege.
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `initialize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `new'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:651:in `connect'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:242:in `initialize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:44:in `new'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/postgresql_adapter.rb:44:in `postgresql_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:438:in `new_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:448:in `checkout_new_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:422:in `acquire_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:349:in `block in checkout'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:348:in `checkout'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:263:in `block in connection'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:262:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:571:in `retrieve_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_handling.rb:113:in `retrieve_connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/connection_handling.rb:87:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/postgresql_database_tasks.rb:6:in `connection'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/postgresql_database_tasks.rb:15:in `create'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:93:in `create'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:107:in `block in create_current'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:275:in `block in each_current_configuration'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:274:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:274:in `each_current_configuration'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/tasks/database_tasks.rb:106:in `create_current'
/app/vendor/bundle/ruby/2.3.0/gems/activerecord-4.2.6/lib/active_record/railties/databases.rake:17:in `block (2 levels) in <top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:248:in `block in execute'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:243:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:243:in `execute'
/app/vendor/bundle/ruby/2.3.0/gems/airbrake-5.4.1/lib/airbrake/rake/task_ext.rb:19:in `execute'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:187:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:209:in `block in invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:186:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:209:in `block in invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:207:in `invoke_prerequisites'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:186:in `block in invoke_with_call_chain'
/app/vendor/ruby-2.3.1/lib/ruby/2.3.0/monitor.rb:214:in `mon_synchronize'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:180:in `invoke_with_call_chain'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/task.rb:173:in `invoke'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:150:in `invoke_task'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `block (2 levels) in top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `each'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:106:in `block in top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:115:in `run_with_threads'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:100:in `top_level'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:78:in `block in run'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:176:in `standard_exception_handling'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/lib/rake/application.rb:75:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/rake-11.1.2/bin/rake:33:in `<top (required)>'
/app/vendor/bundle/ruby/2.3.0/bin/rake:23:in `load'
/app/vendor/bundle/ruby/2.3.0/bin/rake:23:in `<top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:74:in `load'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:74:in `kernel_load'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli/exec.rb:27:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:332:in `exec'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/command.rb:27:in `run'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/invocation.rb:126:in `invoke_command'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor.rb:359:in `dispatch'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:20:in `dispatch'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/vendor/thor/lib/thor/base.rb:440:in `start'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/cli.rb:11:in `start'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/exe/bundle:34:in `block in <top (required)>'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/lib/bundler/friendly_errors.rb:100:in `with_friendly_errors'
/app/vendor/bundle/ruby/2.3.0/gems/bundler-1.13.4/exe/bundle:26:in `<top (required)>'
/app/bin/bundle:3:in `load'
/app/bin/bundle:3:in `<main>'
Couldn't create database for {"adapter"=>"postgresql", "encoding"=>"unicode", "database"=>"....", "pool"=>20, "username"=>"...", "password"=>"....", "port"=>5432, "host"=>"ec2-54-247-98-197.eu-west-1.compute.amazonaws.com"}
-- enable_extension("plpgsql")
   -> 0.0495s
-- create_table("activities", {:force=>:cascade})
   -> 0.0206s
-- add_index("activities", ["owner_id", "owner_type"], {:name=>"index_activities_on_owner_id_and_owner_type", :using=>:btree})
   -> 0.0077s
-- add_index("activities", ["recipient_id", "recipient_type"], {:name=>"index_activities_on_recipient_id_and_recipient_type", :using=>:btree})
   -> 0.0060s
-- add_index("activities", ["trackable_id", "trackable_type"], {:name=>"index_activities_on_trackable_id_and_trackable_type", :using=>:btree})
   -> 0.0060s
-- create_table("articles", {:force=>:cascade})
   -> 0.0212s
-- add_index("articles", ["slug"], {:name=>"index_articles_on_slug", :unique=>true, :using=>:btree})
   -> 0.0120s
-- add_index("articles", ["title"], {:name=>"index_articles_on_title", :using=>:btree})
   -> 0.0163s
-- add_index("articles", ["user_id"], {:name=>"index_articles_on_user_id", :using=>:btree})
   -> 0.0078s
-- create_table("authentications", {:force=>:cascade})
   -> 0.0256s
-- add_index("authentications", ["user_id"], {:name=>"index_authentications_on_user_id", :using=>:btree})
   -> 0.0101s
-- create_table("commit_counts", {:force=>:cascade})
   -> 0.0124s
-- add_index("commit_counts", ["project_id"], {:name=>"index_commit_counts_on_project_id", :using=>:btree})
   -> 0.0077s
-- add_index("commit_counts", ["user_id"], {:name=>"index_commit_counts_on_user_id", :using=>:btree})
   -> 0.0085s
-- create_table("documents", {:force=>:cascade})
   -> 0.0177s
-- add_index("documents", ["project_id"], {:name=>"index_documents_on_project_id", :using=>:btree})
   -> 0.0071s
-- add_index("documents", ["slug", "user_id"], {:name=>"index_documents_on_slug_and_user_id", :unique=>true, :using=>:btree})
   -> 0.0076s
-- add_index("documents", ["user_id"], {:name=>"index_documents_on_user_id", :using=>:btree})
   -> 0.0078s
-- create_table("event_instances", {:force=>:cascade})
   -> 0.0232s
-- create_table("events", {:force=>:cascade})
   -> 0.0163s
-- add_index("events", ["slug"], {:name=>"index_events_on_slug", :unique=>true, :using=>:btree})
   -> 0.0079s
-- add_index("events", ["start_datetime"], {:name=>"index_events_on_start_datetime", :using=>:btree})
   -> 0.0081s
-- create_table("follows", {:force=>:cascade})
   -> 0.0284s
-- add_index("follows", ["followable_id", "followable_type"], {:name=>"fk_followables", :using=>:btree})
   -> 0.0073s
-- add_index("follows", ["follower_id", "follower_type"], {:name=>"fk_follows", :using=>:btree})
   -> 0.0126s
-- create_table("hangout_participants_snapshots", {:force=>:cascade})
   -> 0.0281s
-- create_table("karmas", {:force=>:cascade})
   -> 0.0183s
-- create_table("newsletters", {:force=>:cascade})
   -> 0.0259s
-- create_table("projects", {:force=>:cascade})
   -> 0.0183s
-- add_index("projects", ["slug"], {:name=>"index_projects_on_slug", :unique=>true, :using=>:btree})
   -> 0.0096s
-- add_index("projects", ["user_id"], {:name=>"index_projects_on_user_id", :using=>:btree})
   -> 0.0161s
-- create_table("static_pages", {:force=>:cascade})
   -> 0.0167s
-- add_index("static_pages", ["slug"], {:name=>"index_static_pages_on_slug", :unique=>true, :using=>:btree})
   -> 0.0076s
-- create_table("statuses", {:force=>:cascade})
   -> 0.0151s
-- create_table("taggings", {:force=>:cascade})
   -> 0.0165s
-- add_index("taggings", ["tag_id", "taggable_id", "taggable_type", "context", "tagger_id", "tagger_type"], {:name=>"taggings_idx", :unique=>true, :using=>:btree})
   -> 0.0070s
-- add_index("taggings", ["taggable_id", "taggable_type", "context"], {:name=>"index_taggings_on_taggable_id_and_taggable_type_and_context", :using=>:btree})
   -> 0.0068s
-- add_index("taggings", ["tagger_id"], {:name=>"index_taggings_on_tagger_id", :using=>:btree})
   -> 0.0078s
-- add_index("taggings", ["tagger_type"], {:name=>"index_taggings_on_tagger_type", :using=>:btree})
   -> 0.0076s
-- create_table("tags", {:force=>:cascade})
   -> 0.0239s
-- add_index("tags", ["name"], {:name=>"index_tags_on_name", :unique=>true, :using=>:btree})
   -> 0.0106s
-- create_table("users", {:force=>:cascade})
   -> 0.0369s
-- add_index("users", ["email"], {:name=>"index_users_on_email", :unique=>true, :using=>:btree})
   -> 0.0063s
-- add_index("users", ["reset_password_token"], {:name=>"index_users_on_reset_password_token", :unique=>true, :using=>:btree})
   -> 0.0070s
-- add_index("users", ["slug"], {:name=>"index_users_on_slug", :unique=>true, :using=>:btree})
   -> 0.0095s
-- create_table("versions", {:force=>:cascade})
   -> 0.0254s
-- add_index("versions", ["item_type", "item_id"], {:name=>"index_versions_on_item_type_and_item_id", :using=>:btree})
   -> 0.0140s
-- create_table("votes", {:force=>:cascade})
   -> 0.0168s
-- add_index("votes", ["votable_id", "votable_type", "vote_scope"], {:name=>"index_votes_on_votable_id_and_votable_type_and_vote_scope", :using=>:btree})
   -> 0.0086s
-- add_index("votes", ["voter_id", "voter_type", "vote_scope"], {:name=>"index_votes_on_voter_id_and_voter_type_and_vote_scope", :using=>:btree})
   -> 0.0064s
-- add_foreign_key("events", "users", {:column=>"creator_id"})
   -> 0.0042s
-- initialize_schema_migrations_table()
   -> 0.0044s
Clearing existing projects and documents
Added default user with email: random@random.com and password: randomrandom
Created default projects
[ActiveJob] [ActionMailer::DeliveryJob] [eb02ca83-6640-4e1e-802b-a47a2a9e60dc] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "random@random.com", nil, "already_invited"
[ActiveJob] [ActionMailer::DeliveryJob] [eb02ca83-6640-4e1e-802b-a47a2a9e60dc]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (2.8ms)
[ActiveJob] [ActionMailer::DeliveryJob] [eb02ca83-6640-4e1e-802b-a47a2a9e60dc] 
Sent mail to support@agileventures.org (1396.9ms)
[ActiveJob] [ActionMailer::DeliveryJob] [eb02ca83-6640-4e1e-802b-a47a2a9e60dc] Performed ActionMailer::DeliveryJob from Inline(mailers) in 1853.61ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: eb02ca83-6640-4e1e-802b-a47a2a9e60dc) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "random@random.com", nil, "already_invited"
Created Static Page: Personal Tuition Service
Created Static Page: Saas Ells Screencasts
Created Static Page: Remote Pair Programming
Created Static Page: Sortable Ells Errata
Created Static Page: Getting Started
Created Static Page: Grow
Created Static Page: Learn1
Created Static Page: Code
Created Static Page: Cs Degree Online
Created Static Page: About Us
Created Static Page: Pair
Created Static Page: Ubuntu Bash Help
Created Static Page: Berkeley Fall 2012 Projects
Created Static Page: Sponsors
Created Static Page: Guides
Created Static Page: Remote Pair Programming/Pair Programming Help Videos
Created Static Page: Remote Pair Programming/Pair Programming Calendar
Created Static Page: Remote Pair Programming/Analysis
Created Static Page: Remote Pair Programming/C9 Howto
Created Static Page: Remote Pair Programming/Creating A Pp Event On G
Created Static Page: Remote Pair Programming/Example Videos
Created Static Page: Remote Pair Programming/Gnu Screen Pairing Notes
Created Static Page: Remote Pair Programming/Pair Programming Form
Created Static Page: Remote Pair Programming/Pair Programming Protocols
Created Static Page: Remote Pair Programming/Pair Programming Protocols/Github Pong
Created Static Page: Remote Pair Programming/Pair Programming Protocols/Classroom Guidelines
Project.count 0 -> 9
Document.count 0 -> 18
User.count 0 -> 301
Article.count 0 -> 12
Event.count 0 -> 2
Queued jobs didn't finish before shutdown_timeout...killing remaining jobs
[ActiveJob] [ActionMailer::DeliveryJob] [5e031a66-e222-43c1-8085-78a757e9cf10] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "zoila_kutch@littel.biz", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [5e031a66-e222-43c1-8085-78a757e9cf10]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (0.1ms)
[ActiveJob] [ActionMailer::DeliveryJob] [d9a6af3d-c5c1-4c84-82fc-4a00cf4a9a4d] Performing ActionMailer::DeliveryJob from Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "adell@bahringer.co", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [d9a6af3d-c5c1-4c84-82fc-4a00cf4a9a4d]   Rendered admin_mailer/failed_to_invite_user_to_slack.html.erb within layouts/mailer (0.0ms)
[ActiveJob] [ActionMailer::DeliveryJob] [d9a6af3d-c5c1-4c84-82fc-4a00cf4a9a4d] 
Sent mail to support@agileventures.org (211.0ms)
[ActiveJob] [ActionMailer::DeliveryJob] [d9a6af3d-c5c1-4c84-82fc-4a00cf4a9a4d] Performed ActionMailer::DeliveryJob from Inline(mailers) in 216.8ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: d9a6af3d-c5c1-4c84-82fc-4a00cf4a9a4d) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "adell@bahringer.co", nil, nil
[ActiveJob] [ActionMailer::DeliveryJob] [5e031a66-e222-43c1-8085-78a757e9cf10] 
Sent mail to support@agileventures.org (229.4ms)
[ActiveJob] [ActionMailer::DeliveryJob] [5e031a66-e222-43c1-8085-78a757e9cf10] Performed ActionMailer::DeliveryJob from Inline(mailers) in 233.5ms
[ActiveJob] Enqueued ActionMailer::DeliveryJob (Job ID: 5e031a66-e222-43c1-8085-78a757e9cf10) to Inline(mailers) with arguments: "AdminMailer", "failed_to_invite_user_to_slack", "deliver_now", "zoila_kutch@littel.biz", nil, nil

So questions are:

  1. is the DB connect failure actually the problem?
  2. is our app trying to access the DB too early?
  3. is the slack failures a problem?
  4. what's the next step, apart from waiting for heroku support ...?
tansaku commented 8 years ago

ah, maybe it's airbrake that's the issue ...

tansaku commented 8 years ago

tried upgrading to latest airbrake gem - still getting fail passing through:

/app/vendor/bundle/ruby/2.3.0/gems/airbrake-5.6.0/lib/airbrake/rake/task_ext.rb:19:in `execute'

seems like this stack is just coming from running the bundle ... hmmm

tansaku commented 8 years ago

also, why is this on ruby 2.3.0 when our Gemfile specifies 2.3.1 ...?