Skip to content

Instantly share code, notes, and snippets.

@samflores

samflores/renewal-order-creation.log

Created November 5, 2018 23:16
Show Gist options
  • Save samflores/2c837ca7a9f59fe33cfbf1be82449358 to your computer and use it in GitHub Desktop.
Save samflores/2c837ca7a9f59fe33cfbf1be82449358 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
renewal-order-creation.log
> RecurringSales::Renewal::CreateOrder.call(recurring_sale, next_renewal_date: Time.current - 1.day)
D, [2018-11-05T23:13:28.394607 #69] DEBUG -- : (203.9ms) BEGIN
D, [2018-11-05T23:13:28.549376 #69] DEBUG -- : (148.1ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:28.711214 #69] DEBUG -- : (159.3ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:28.906474 #69] DEBUG -- : (192.4ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:29.111299 #69] DEBUG -- : (202.1ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:29.316068 #69] DEBUG -- : SQL (192.6ms) INSERT INTO `orders` (`user_id`, `created_at`, `updated_at`, `price_in_cents`, `publisher_id`, `sale_price_in_cents`, `invoice_currency`) VALUES (5988563, '2018-11-05 23:13:29', '2018-11-05 23:13:29', 2900, 1, 2900, 'USD')
D, [2018-11-05T23:13:29.521139 #69] DEBUG -- : SQL (204.0ms) UPDATE `users` SET `orders_count` = COALESCE(`orders_count`, 0) + 1 WHERE `users`.`id` = 5988563
D, [2018-11-05T23:13:29.726011 #69] DEBUG -- : (197.2ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:29.930626 #69] DEBUG -- : (201.5ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:30.135346 #69] DEBUG -- : (201.6ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:30.340192 #69] DEBUG -- : (202.2ms) SELECT COUNT(*) FROM `products` INNER JOIN `product_sales` ON `products`.`id` = `product_sales`.`product_id` INNER JOIN `sales` ON `product_sales`.`sale_id` = `sales`.`id` WHERE `sales`.`id` = 16484
D, [2018-11-05T23:13:30.544750 #69] DEBUG -- : SQL (201.5ms) INSERT INTO `order_line_items` (`order_id`, `sale_id`, `paid_price_cents`, `created_at`, `updated_at`, `unit_price_cents`, `state`) VALUES (10572180, 16484, 2900, '2018-11-05 23:13:30', '2018-11-05 23:13:30', 2900, 'pending')
D, [2018-11-05T23:13:30.749890 #69] DEBUG -- : SQL (202.8ms) INSERT INTO `recurring_sale_orders` (`recurring_sale_id`, `order_id`, `created_at`, `updated_at`) VALUES (2, 10572180, '2018-11-05 23:13:30', '2018-11-05 23:13:30')
D, [2018-11-05T23:13:30.954893 #69] DEBUG -- : OrderTransition Load (201.2ms) SELECT `order_transitions`.* FROM `order_transitions` WHERE `order_transitions`.`order_id` = 10572180 ORDER BY `order_transitions`.`sort_key` DESC LIMIT 1
D, [2018-11-05T23:13:31.159434 #69] DEBUG -- : OrderTransition Load (202.6ms) SELECT `order_transitions`.* FROM `order_transitions` WHERE `order_transitions`.`order_id` = 10572180 ORDER BY `order_transitions`.`sort_key` DESC LIMIT 1
D, [2018-11-05T23:13:31.364406 #69] DEBUG -- : SQL (201.0ms) UPDATE `order_transitions` SET `order_transitions`.`most_recent` = NULL, `order_transitions`.`updated_at` = '2018-11-05 23:13:31' WHERE `order_transitions`.`order_id` = 10572180 AND `order_transitions`.`most_recent` = 1
D, [2018-11-05T23:13:31.519253 #69] DEBUG -- : SQL (152.1ms) INSERT INTO `order_transitions` (`to_state`, `metadata`, `sort_key`, `order_id`, `most_recent`, `created_at`, `updated_at`) VALUES ('complete', '{}', 10, 10572180, 1, '2018-11-05 23:13:31', '2018-11-05 23:13:31')
D, [2018-11-05T23:13:31.681431 #69] DEBUG -- : SQL (159.3ms) UPDATE `orders` SET `orders`.`completed_at` = '2018-11-05 23:13:31' WHERE `orders`.`id` = 10572180
D, [2018-11-05T23:13:32.081271 #69] DEBUG -- : Sale Load (396.6ms) SELECT `sales`.* FROM `sales` WHERE `sales`.`id` = 16484 LIMIT 1
D, [2018-11-05T23:13:32.540573 #69] DEBUG -- : ProductSale Load (453.9ms) SELECT `product_sales`.* FROM `product_sales` WHERE `product_sales`.`sale_id` = 16484 ORDER BY product_sales.position ASC
D, [2018-11-05T23:13:33.311308 #69] DEBUG -- : Product Load (767.5ms) SELECT `products`.* FROM `products` WHERE `products`.`id` IN (24196, 24197, 24198, 24199, 24200, 24201, 24202, 24203)
D, [2018-11-05T23:13:33.468782 #69] DEBUG -- : Sale Load (152.5ms) SELECT DISTINCT `sales`.* FROM `sales` INNER JOIN `order_line_items` ON `sales`.`id` = `order_line_items`.`sale_id` WHERE `order_line_items`.`order_id` = 10572180
D, [2018-11-05T23:13:33.720246 #69] DEBUG -- : OrderStat Load (247.9ms) SELECT `order_stats`.* FROM `order_stats` WHERE `order_stats`.`order_id` = 10572180 AND `order_stats`.`sale_id` = 16484 ORDER BY `order_stats`.`id` ASC LIMIT 1
D, [2018-11-05T23:13:33.875453 #69] DEBUG -- : SQL (148.2ms) INSERT INTO `order_stats` (`order_id`, `sum_amount_in_cents`, `sum_fees_in_cents`, `sum_partner_earnings_in_cents`, `sum_publisher_earnings_in_cents`, `sum_affiliate_earnings_in_cents`, `refunded`, `created_at`, `updated_at`, `sum_refunds_in_cents`, `sale_id`) VALUES (10572180, 0, 0, 0, 0, 0, 0, '2018-11-05 23:13:33', '2018-11-05 23:13:33', 0, 16484)
D, [2018-11-05T23:13:34.129336 #69] DEBUG -- : RecurringSaleOrder Exists (244.5ms) SELECT 1 AS one FROM `recurring_sale_orders` WHERE `recurring_sale_orders`.`lead` = 0 AND `recurring_sale_orders`.`order_id` = 10572180 LIMIT 1
D, [2018-11-05T23:13:44.676383 #69] DEBUG -- : (207.5ms) ROLLBACK
Redis::CannotConnectError: Error connecting to Redis on stack-redis-beta.blic4q.ng.0001.use1.cache.amazonaws.com:6379 (Redis::TimeoutError)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment