Django ORM對數據庫操做的封裝至關完善,平常大部分數據庫操做均可以經過ORM實現。但django將查詢過程隱藏在了後臺,這在開發時可能會略顯晦澀,而且使用方式不當還會形成開銷過大。python
那麼如何查看django什麼時候執行了什麼sql語句呢?答案是使用Logging。sql
先直接上方法,在settings.py中加入LOGGING選項,調整logging等級爲DEBUG便可:shell
LOGGING = { 'version': 1, 'disable_existing_loggers': False, 'formatters': { 'simple': { 'format': '[%(asctime)s] %(message)s' }, }, 'handlers': { 'console': { 'level': 'DEBUG', 'class': 'logging.StreamHandler', 'formatter': 'simple' }, }, 'loggers': { 'django': { 'handlers': ['console'], 'level': 'DEBUG', }, }, }
而後啓動runserver
,瀏覽須要訪問數據庫的頁面,在shell中便可看見相關日誌,以下:數據庫
[2018-04-21 21:09:14,676] (0.002) SELECT `blog_article`.`id`, `blog_article`.`title`, `blog_article`.`cover`, `blog_article`.`content`, `blog_article`.`pub_date`, `blog_article`.`category_id`, `blog_article`.`views`, `blog_category`.`id`, `blog_category`.`name` FROM `blog_article` INNER JOIN `blog_category` ON (`blog_article`.`category_id` = `blog_category`.`id`) WHERE `blog_article`.`pub_date` < '2018-04-21 13:09:14.601856' ORDER BY `blog_article`.`pub_date` DESC LIMIT 10; args=('2018-04-21 13:09:14.601856',) [2018-04-21 21:09:14,678] (0.000) SELECT (`blog_article_topics`.`article_id`) AS `_prefetch_related_val_article_id`, `blog_topic`.`id`, `blog_topic`.`name`, `blog_topic`.`number` FROM `blog_topic` INNER JOIN `blog_article_topics` ON (`blog_topic`.`id` = `blog_article_topics`.`topic_id`) WHERE `blog_article_topics`.`article_id` IN (3, 4, 5, 6, 7, 8, 9, 10, 11, 12) ORDER BY `blog_topic`.`number` ASC; args=(3, 4, 5, 6, 7, 8, 9, 10, 11, 12) [2018-04-21 21:09:14,708] "GET / HTTP/1.1" 200 22325
上面打印出的日誌是個人博客首頁獲取前十篇文章時所執行的部分SQL語句,其對應的QuerySet爲django
Article.objects.filter(pub_date__lt=timezone.now())[:10] \ .defer('author', 'category__number') \ .select_related('category') \ .prefetch_related('topics')
經過Logging
不只能夠查看SQL語句,還能夠由此知道django什麼時候執行了SQL。在某些狀況下咱們能夠經過這種方式判斷,後臺是否重複執行了SQL語句,便於指導數據庫訪問優化。fetch
Django使用Python的內建的logging模塊執行系統日誌記錄。優化
原文連接
本文首發於 BigYoung小站