Skip to content

Instantly share code, notes, and snippets.

@cmrd-senya

cmrd-senya/pod-who-liked

Created October 10, 2015 02:10
Show Gist options
  • Save cmrd-senya/4d45c41d0b8313e98653 to your computer and use it in GitHub Desktop.
Save cmrd-senya/4d45c41d0b8313e98653 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
pod-who-liked
[2015-10-10T04:49:57] DEBUG PID-2815 TID-18831720 Rails:
[2015-10-10T04:49:57] DEBUG PID-2815 TID-18831720 Rails:
[2015-10-10T04:49:57] INFO PID-2815 TID-18831720 Rails: Started POST "/posts/6/likes" for 192.168.56.103 at 2015-10-10 04:49:57 +0300
[2015-10-10T04:49:58] INFO PID-2815 TID-18831720 ActionController::Base: Processing by LikesController#create as JSON
[2015-10-10T04:49:58] INFO PID-2815 TID-18831720 ActionController::Base: Parameters: {"post_id"=>"6", "like"=>{}}
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: User Load (0.7ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 ORDER BY "users"."id" ASC LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Load (1.7ms) SELECT posts.* FROM "posts" INNER JOIN "share_visibilities" ON "share_visibilities"."shareable_id" = "posts"."id" AND "share_visibilities"."shareable_type" = $1 INNER JOIN "contacts" ON "contacts"."id" = "share_visibilities"."contact_id" WHERE "posts"."id" = $2 AND "contacts"."user_id" = $3 ORDER BY "posts"."id" ASC LIMIT 1 [["shareable_type", "Post"], ["id", 6], ["user_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = $1 AND "posts"."author_id" = $2 ORDER BY "posts"."id" ASC LIMIT 1 [["id", 6], ["author_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = $1 AND "posts"."public" = $2 ORDER BY "posts"."id" ASC LIMIT 1 [["id", 6], ["public", "t"]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Participation Load (0.4ms) SELECT "participations".* FROM "participations" WHERE "participations"."author_id" = $1 AND "participations"."target_id" = 6 ORDER BY "participations"."id" ASC LIMIT 1 [["author_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: User Load (0.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] INFO PID-2815 TID-18831720 Participation: event=sign_with_key status=complete guid=22b78480511f0133e4640800276d7a8d
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: (0.1ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.5ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 1) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: SQL (0.4ms) INSERT INTO "participations" ("target_id", "target_type", "author_id", "guid", "author_signature", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id" [["target_id", 6], ["target_type", "Post"], ["author_id", 1], ["guid", "22b78480511f0133e4640800276d7a8d"], ["author_signature", "pyiunr74cbW3RlAlAuwlS9N44MFwo/8RV6c1zp3MYR/mruqDv30/gezbx6Lhte3iElvLy+UkLZ1saxwf+uO1k4GrvQ0ZsjKdNo0g7pkM1ffCVmrzBteI00WPh4+go2aDZP5EhrHODDH94Bec840XDleun/cw65C6ej2R8k3Rl+YRpL//SxgG16dQx6ieotwhdTXILueJciDbr1L6vpHZjvhV1wKEOW6ZSQuSnwbNj3vtWcGqv6XwrEHhuPLDHIhyho4VS3SCiCpIrtfKp1XWicXNegNUgUVhXPHZkIMVgPPatSm/MggOV2t+hcidzB9ntrgcod8iKAt741SY+wNGX9xNyGVoEdlYQeOL/m/M+tOVPsD+30cO1O1CxM3bobV0H2fSRcYwvgorZEHPUkabs7eO3qv3rFH0T2HjB9ulC8Zh0Sj9GKsDC2zJgZ8qpmMtj0JFLGtvCSDy7w2iUsbBheCb4WbWA/jUgfo9KbVzS60s5+Y6ydoN6oupnv6xttX3LY6uiRNBP28C+VHsuqofnbOfRrR3ynLroOtGJEj6ZEwrDePVS5DwXuM0EpC/DPRBnOBzVgHw7P77HZ6QHD7GCYb3XnkyJ5Q4NjXW46kJYJWzaoc/NXf7HN6MWsOWPv1F12iFnpWBg9TFdKiaWN4a+MsYojXWpM+46ZjOOEmKOs0="], ["created_at", "2015-10-10 01:49:58.090461"], ["updated_at", "2015-10-10 01:49:58.090461"]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: (8.8ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: (0.3ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: SQL (1.4ms) UPDATE "posts" SET "updated_at" = '2015-10-10 01:49:58.106630', "interacted_at" = '2015-10-10 01:49:58.106630' WHERE "posts"."type" IN ('StatusMessage') AND "posts"."id" = $1 [["id", 6]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: (7.2ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Mention Exists (0.5ms) SELECT 1 AS one FROM "mentions" WHERE "mentions"."post_id" = $1 LIMIT 1 [["post_id", 6]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Mention Load (0.4ms) SELECT "mentions".* FROM "mentions" WHERE "mentions"."post_id" = $1 [["post_id", 6]]
[2015-10-10T04:49:58] INFO PID-2815 TID-18831720 Participation::Generator: user:1 dispatching Participation:22b78480511f0133e4640800276d7a8d
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: User Load (0.9ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Participation Load (0.3ms) SELECT "participations".* FROM "participations" WHERE "participations"."id" = $1 LIMIT 1 [["id", 14]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Post Load (0.4ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = $1 LIMIT 1 [["id", 6]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.3ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.7ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Service Load (0.5ms) SELECT "services".* FROM "services" WHERE "services"."user_id" = $1 AND "services"."type" IS NULL [["user_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 Rails: ETHON: Libcurl initialized
[2015-10-10T04:49:58] DEBUG PID-2815 TID-18831720 Rails: ETHON: started MULTI
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed EASY effective_url=http://192.168.56.102/receive/public response_code=0 return_code=operation_timedout total_time=0.200187
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: Pod Load (0.5ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.102"]]
[2015-10-10T04:50:23] WARN PID-2815 TID-18831720 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.102/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed MULTI
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:50:23] DEBUG PID-2815 TID-18831720 Rails: ETHON: started MULTI
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed EASY effective_url=http://192.168.56.102/receive/public response_code=0 return_code=operation_timedout total_time=0.200405
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.1ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.102"]]
[2015-10-10T04:50:48] WARN PID-2815 TID-18831720 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.102/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed MULTI
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:50:48] DEBUG PID-2815 TID-18831720 Rails: ETHON: started MULTI
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed EASY effective_url=http://192.168.56.102/receive/public response_code=0 return_code=operation_timedout total_time=0.202368
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.102"]]
[2015-10-10T04:51:13] WARN PID-2815 TID-18831720 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.102/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 Rails: ETHON: performed MULTI
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:51:13] DEBUG PID-2815 TID-18831720 Rails: ETHON: started MULTI
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:29] INFO PID-2865 TID-18831720 Rails: Started POST "/receive/public" for 192.168.56.103 at 2015-10-10 04:51:29 +0300
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: ActiveRecord::SchemaMigration Load (0.7ms) SELECT "schema_migrations".* FROM "schema_migrations"
[2015-10-10T04:51:29] INFO PID-2865 TID-18831720 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:29] INFO PID-2865 TID-18831720 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:29] WARN PID-2865 TID-18831720 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:29] INFO PID-2865 TID-18831720 PublicsController: received a public message
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.7ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (1.0ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Load (0.9ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.5ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 1]]
[2015-10-10T04:51:29] INFO PID-2865 TID-18831720 Postzord::Receiver::Public: starting public receive from person:c902fa60511801339ba708002711e652
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.3ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.2ms) BEGIN
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (2.1ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.8ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (2.1ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (1.1ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (0.5ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 1) LIMIT 1
[2015-10-10T04:51:29] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.3ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Completed 200 OK in 647ms (Views: 21.1ms | ActiveRecord: 23.8ms)
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Rails: Started POST "/receive/public" for 192.168.56.103 at 2015-10-10 04:51:30 +0300
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 PublicsController: received a public message
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.5ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.6ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Load (1.7ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.5ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.4ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 1]]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Postzord::Receiver::Public: starting public receive from person:c902fa60511801339ba708002711e652
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.5ms) BEGIN
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (2.0ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.5ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (0.7ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (1.1ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 1) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.2ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Completed 200 OK in 68ms (Views: 1.0ms | ActiveRecord: 9.6ms)
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Rails: Started POST "/receive/public" for 192.168.56.103 at 2015-10-10 04:51:30 +0300
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 PublicsController: received a public message
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.4ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Load (0.6ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (1.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.6ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 1]]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Postzord::Receiver::Public: starting public receive from person:c902fa60511801339ba708002711e652
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.7ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.3ms) BEGIN
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (0.5ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.6ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (1.1ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (0.7ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (0.7ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 1) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.6ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Completed 200 OK in 64ms (Views: 1.4ms | ActiveRecord: 8.2ms)
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 Rails:
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Rails: Started POST "/receive/public" for 192.168.56.103 at 2015-10-10 04:51:30 +0300
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 PublicsController: received a public message
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.5ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.3ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Load (1.6ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Profile Load (0.3ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 1]]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 Postzord::Receiver::Public: starting public receive from person:c902fa60511801339ba708002711e652
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.1ms) BEGIN
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (1.5ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: Participation Exists (0.6ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 1) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-2865 TID-18831720 ActiveRecord::Base: (0.6ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-2865 TID-18831720 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-2865 TID-18831720 ActionController::Base: Completed 200 OK in 62ms (Views: 0.7ms | ActiveRecord: 7.7ms)
Raw
pod-who-was-liked
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 Rails:
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 Rails:
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 Rails: Started POST "/receive/public" for 192.168.56.102 at 2015-10-10 04:49:58 +0300
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:49:58] WARN PID-4643 TID-3996000 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 PublicsController: received a public message
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Profile Load (0.6ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Load (0.6ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 Postzord::Receiver::Public: starting public receive from person:fbf3bf5051160133e4440800276d7a8d
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (0.4ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (0.9ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.5ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: User Load (0.6ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Exists (0.7ms) SELECT 1 AS one FROM "people" INNER JOIN "blocks" ON "people"."id" = "blocks"."person_id" WHERE "blocks"."user_id" = $1 AND "people"."id" = $2 LIMIT 1 [["user_id", 1], ["id", 2]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (0.9ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: SQL (0.4ms) INSERT INTO "participations" ("guid", "target_type", "target_id", "author_signature", "author_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id" [["guid", "22b78480511f0133e4640800276d7a8d"], ["target_type", "Post"], ["target_id", 6], ["author_signature", "pyiunr74cbW3RlAlAuwlS9N44MFwo/8RV6c1zp3MYR/mruqDv30/gezbx6Lhte3iElvLy+UkLZ1saxwf+uO1k4GrvQ0ZsjKdNo0g7pkM1ffCVmrzBteI00WPh4+go2aDZP5EhrHODDH94Bec840XDleun/cw65C6ej2R8k3Rl+YRpL//SxgG16dQx6ieotwhdTXILueJciDbr1L6vpHZjvhV1wKEOW6ZSQuSnwbNj3vtWcGqv6XwrEHhuPLDHIhyho4VS3SCiCpIrtfKp1XWicXNegNUgUVhXPHZkIMVgPPatSm/MggOV2t+hcidzB9ntrgcod8iKAt741SY+wNGX9xNyGVoEdlYQeOL/m/M+tOVPsD+30cO1O1CxM3bobV0H2fSRcYwvgorZEHPUkabs7eO3qv3rFH0T2HjB9ulC8Zh0Sj9GKsDC2zJgZ8qpmMtj0JFLGtvCSDy7w2iUsbBheCb4WbWA/jUgfo9KbVzS60s5+Y6ydoN6oupnv6xttX3LY6uiRNBP28C+VHsuqofnbOfRrR3ynLroOtGJEj6ZEwrDePVS5DwXuM0EpC/DPRBnOBzVgHw7P77HZ6QHD7GCYb3XnkyJ5Q4NjXW46kJYJWzaoc/NXf7HN6MWsOWPv1F12iFnpWBg9TFdKiaWN4a+MsYojXWpM+46ZjOOEmKOs0="], ["author_id", 2], ["created_at", "2015-10-10 01:49:58.290139"], ["updated_at", "2015-10-10 01:49:58.290139"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (4.5ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (0.1ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: SQL (0.5ms) UPDATE "posts" SET "updated_at" = '2015-10-10 01:49:58.300237', "interacted_at" = '2015-10-10 01:49:58.300237' WHERE "posts"."type" IN ('StatusMessage') AND "posts"."id" = $1 [["id", 6]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (4.3ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Mention Exists (0.6ms) SELECT 1 AS one FROM "mentions" WHERE "mentions"."post_id" = $1 LIMIT 1 [["post_id", 6]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Mention Load (0.2ms) SELECT "mentions".* FROM "mentions" WHERE "mentions"."post_id" = $1 [["post_id", 6]]
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 Postzord::Receiver::Public: received a #<Participation id: 13, guid: "22b78480511f0133e4640800276d7a8d", target_id: 6, target_type: "Post", author_id: 2, author_signature: "pyiunr74cbW3RlAlAuwlS9N44MFwo/8RV6c1zp3MYR/mruqDv3...", parent_author_signature: nil, created_at: "2015-10-10 01:49:58", updated_at: "2015-10-10 01:49:58", count: 1>
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Load (0.4ms) SELECT "participations".* FROM "participations" WHERE "participations"."guid" = $1 ORDER BY "participations"."id" ASC LIMIT 1 [["guid", "22b78480511f0133e4640800276d7a8d"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Load (0.3ms) SELECT "posts".* FROM "posts" WHERE "posts"."id" = $1 LIMIT 1 [["id", 6]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.2ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 2]]
[2015-10-10T04:49:58] INFO PID-4643 TID-3996000 Participation: event=sign_with_key status=complete guid=22b78480511f0133e4640800276d7a8d
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (0.2ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (0.5ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."guid" = '22b78480511f0133e4640800276d7a8d' AND "participations"."id" != 13) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.5ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."id" != 13 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: SQL (0.4ms) UPDATE "participations" SET "parent_author_signature" = $1, "updated_at" = $2 WHERE "participations"."id" = $3 [["parent_author_signature", "mj5hk5t6tMrZHfEPTj+CUyPLTt8kTSRGqwbL+9rsWeRe70K/5i9f3eZLiXTBC7rhZaJe/cBb7Hj9unCmcKF6L0jebzbGqbrH5jEeh8OO1u9UH+AhChtPUdVsaPh/kkMSK5HnKQw8KBm0zmbO07RPsjhfgcrY3bxx0I9+NhNQDgPXclzrndUelv6A63Ptsg8fMBwwC+Co0fuyTWjafdqMY/RMDyAaaNCc9hNgoB8LSmZ33Z8Fw5OThAofsNst7nia8IN3v8kju3pS4+M8cK6UT+HPmoujGcuNUrZFmekipcGWUJJWdI0w3+f15Cy+u71ekRNe+kgp9vmDVXL3ONt70pohURL/+Hh/T5vdwgSFD6doNGmsQtvy+UgdBcT7W1YtxbEYXQzlfwugx3g+XsI072lxVRz0yQSDhw7/dafY+xJ7/VLAYReuycZDvn3O94UpRAbSIKWjqHdCUInhvA4+oJxAudDqb35H2fw3+vFKsxQGvQqjo3DdWaHbCLPElvT2dmGhzgAmbe5pPgeHB9oRavpW2wPJcRMQiqA2X+hYrKwaQKRMr8ihVqZeSXX995irtIF9IjED872Fvd1HmZKcFNQKOEoLAp/SQPX6JYTDslrv/Lak0xzHpKP2n9IzG6l4i3uEELNrP62nL9U6lWx+H/5wmHbUzOtKASsXxlL6kQg="], ["updated_at", "2015-10-10 01:49:58.365620"], ["id", 13]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (4.5ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (0.2ms) BEGIN
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (1.4ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."guid" = '22b78480511f0133e4640800276d7a8d' AND "participations"."id" != 13) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Post Exists (0.4ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."id" != 13 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: (0.3ms) COMMIT
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.5ms) SELECT "people".* FROM "people" INNER JOIN "contacts" ON "people"."id" = "contacts"."person_id" WHERE "contacts"."user_id" = $1 [["user_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: User Load (0.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (1.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 Rails: ETHON: Libcurl initialized
[2015-10-10T04:49:58] DEBUG PID-4643 TID-3996000 Rails: ETHON: started MULTI
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed EASY effective_url=http://192.168.56.103/receive/public response_code=0 return_code=operation_timedout total_time=0.200439
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: Pod Load (0.6ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.103"]]
[2015-10-10T04:50:23] WARN PID-4643 TID-3996000 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.103/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed MULTI
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.1ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:50:23] DEBUG PID-4643 TID-3996000 Rails: ETHON: started MULTI
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed EASY effective_url=http://192.168.56.103/receive/public response_code=0 return_code=operation_timedout total_time=0.201038
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.103"]]
[2015-10-10T04:50:48] WARN PID-4643 TID-3996000 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.103/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed MULTI
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:50:48] DEBUG PID-4643 TID-3996000 Rails: ETHON: started MULTI
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed EASY effective_url=http://192.168.56.103/receive/public response_code=0 return_code=operation_timedout total_time=0.200404
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.3ms) SELECT "pods".* FROM "pods" WHERE "pods"."host" = $1 LIMIT 1 [["host", "192.168.56.103"]]
[2015-10-10T04:51:13] WARN PID-4643 TID-3996000 HydraWrapper: event=http_multi_fail sender_id=1 url=http://192.168.56.103/receive/public return_code=operation_timedout response_code=0
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 Rails: ETHON: performed MULTI
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = 2
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."owner_id" = $1 LIMIT 1 [["owner_id", 1]]
[2015-10-10T04:51:13] DEBUG PID-4643 TID-3996000 Rails: ETHON: started MULTI
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:29] INFO PID-4693 TID-3996000 Rails: Started POST "/receive/public" for 192.168.56.102 at 2015-10-10 04:51:29 +0300
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: ActiveRecord::SchemaMigration Load (0.5ms) SELECT "schema_migrations".* FROM "schema_migrations"
[2015-10-10T04:51:29] INFO PID-4693 TID-3996000 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:29] INFO PID-4693 TID-3996000 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:29] WARN PID-4693 TID-3996000 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:29] INFO PID-4693 TID-3996000 PublicsController: received a public message
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (1.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Profile Load (0.7ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Load (0.8ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:29] INFO PID-4693 TID-3996000 Postzord::Receiver::Public: starting public receive from person:fbf3bf5051160133e4440800276d7a8d
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (1.0ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.2ms) BEGIN
[2015-10-10T04:51:29] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.8ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.8ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.6ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.9ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: User Load (2.1ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Exists (0.4ms) SELECT 1 AS one FROM "people" INNER JOIN "blocks" ON "people"."id" = "blocks"."person_id" WHERE "blocks"."user_id" = $1 AND "people"."id" = $2 LIMIT 1 [["user_id", 1], ["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.5ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.2ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-4693 TID-3996000 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Completed 200 OK in 744ms (Views: 22.7ms | ActiveRecord: 29.1ms)
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 Rails: Started POST "/receive/public" for 192.168.56.102 at 2015-10-10 04:51:30 +0300
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:30] WARN PID-4693 TID-3996000 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 PublicsController: received a public message
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (0.9ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Profile Load (0.5ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Load (0.5ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.2ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 Postzord::Receiver::Public: starting public receive from person:fbf3bf5051160133e4440800276d7a8d
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (0.6ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.2ms) BEGIN
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.6ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (1.6ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.5ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: User Load (0.5ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Exists (0.6ms) SELECT 1 AS one FROM "people" INNER JOIN "blocks" ON "people"."id" = "blocks"."person_id" WHERE "blocks"."user_id" = $1 AND "people"."id" = $2 LIMIT 1 [["user_id", 1], ["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.9ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.6ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-4693 TID-3996000 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Completed 200 OK in 73ms (Views: 1.7ms | ActiveRecord: 8.6ms)
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 Rails:
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 Rails: Started POST "/receive/public" for 192.168.56.102 at 2015-10-10 04:51:30 +0300
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Processing by PublicsController#receive_public as */*
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Parameters: {"xml"=>"[FILTERED]"}
[2015-10-10T04:51:30] WARN PID-4693 TID-3996000 PublicsController: Can't verify CSRF token authenticity
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 PublicsController: received a public message
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Profile Load (0.3ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Load (0.5ms) SELECT "posts".* FROM "posts" WHERE "posts"."guid" = $1 ORDER BY "posts"."id" ASC LIMIT 1 [["guid", "ba5a7a30511c01339bb708002711e652"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "people".* FROM "people" WHERE "people"."diaspora_handle" = $1 LIMIT 1 [["diaspora_handle", "[email protected]"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: CACHE (0.0ms) SELECT "profiles".* FROM "profiles" WHERE "profiles"."person_id" = $1 LIMIT 1 [["person_id", 2]]
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 Postzord::Receiver::Public: starting public receive from person:fbf3bf5051160133e4440800276d7a8d
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Load (0.4ms) SELECT "people".* FROM "people" WHERE "people"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.1ms) BEGIN
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.3ms) SELECT 1 AS one FROM "participations" WHERE "participations"."guid" = '22b78480511f0133e4640800276d7a8d' LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: ActsAsTaggableOn::Tag Load (0.9ms) SELECT "tags".* FROM "tags" INNER JOIN "taggings" ON "tags"."id" = "taggings"."tag_id" WHERE "taggings"."taggable_id" = $1 AND "taggings"."taggable_type" = $2 AND (taggings.context = 'tags' AND taggings.tagger_id IS NULL) [["taggable_id", 6], ["taggable_type", "Post"]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.9ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."guid" = 'ba5a7a30511c01339bb708002711e652' AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Post Exists (0.9ms) SELECT 1 AS one FROM "posts" WHERE ("posts"."id" = 6 AND "posts"."id" != 6) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: User Load (0.4ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 1]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Person Exists (0.4ms) SELECT 1 AS one FROM "people" INNER JOIN "blocks" ON "people"."id" = "blocks"."person_id" WHERE "blocks"."user_id" = $1 AND "people"."id" = $2 LIMIT 1 [["user_id", 1], ["id", 2]]
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: Participation Exists (0.4ms) SELECT 1 AS one FROM "participations" WHERE ("participations"."target_id" = 6 AND "participations"."target_type" = 'Post' AND "participations"."author_id" = 2) LIMIT 1
[2015-10-10T04:51:30] DEBUG PID-4693 TID-3996000 ActiveRecord::Base: (0.2ms) ROLLBACK
[2015-10-10T04:51:30] WARN PID-4693 TID-3996000 Workers::ReceiveUnencryptedSalmon: failed to save received object: ["Guid has already been taken", "Target has already been taken"]
[2015-10-10T04:51:30] INFO PID-4693 TID-3996000 ActionController::Base: Completed 200 OK in 52ms (Views: 0.6ms | ActiveRecord: 6.1ms)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment