4 
 activity                                                                                             | timestamp    | source        | source_elapsed
------------------------------------------------------------------------------------------------------+--------------+---------------+----------------
                                                                                   execute_cql3_query | 06:30:52,479 | 192.168.11.23 |              0
 Parsing select adid from userlastadevents where userid = '90000012' and type in (1,2,3) LIMIT 10000; | 06:30:52,479 | 192.168.11.23 |             44
                                                                                   Peparing statement | 06:30:52,479 | 192.168.11.23 |            146
                                                 Executing single-partition query on userlastadevents | 06:30:52,480 | 192.168.11.23 |            665
                                                                         Acquiring sstable references | 06:30:52,480 | 192.168.11.23 |            680
                                                 Executing single-partition query on userlastadevents | 06:30:52,480 | 192.168.11.23 |            696
                                                                         Acquiring sstable references | 06:30:52,480 | 192.168.11.23 |            704
                                                                          Merging memtable tombstones | 06:30:52,480 | 192.168.11.23 |            706
                                                                          Merging memtable tombstones | 06:30:52,480 | 192.168.11.23 |            721
                                                           Bloom filter allows skipping sstable 37398 | 06:30:52,480 | 192.168.11.23 |            758
                                                           Bloom filter allows skipping sstable 37426 | 06:30:52,480 | 192.168.11.23 |            762
                                                           Bloom filter allows skipping sstable 35504 | 06:30:52,480 | 192.168.11.23 |            768
                                                           Bloom filter allows skipping sstable 36671 | 06:30:52,480 | 192.168.11.23 |            771
                                                           Merging data from memtables and 0 sstables | 06:30:52,480 | 192.168.11.23 |            777
                                                           Merging data from memtables and 0 sstables | 06:30:52,480 | 192.168.11.23 |            780
                                                 Executing single-partition query on userlastadevents | 06:30:52,480 | 192.168.11.23 |            782
                                                                         Acquiring sstable references | 06:30:52,480 | 192.168.11.23 |            791
                                                                   Read 0 live and 0 tombstoned cells | 06:30:52,480 | 192.168.11.23 |            797
                                                                   Read 0 live and 0 tombstoned cells | 06:30:52,480 | 192.168.11.23 |            800
                                                                          Merging memtable tombstones | 06:30:52,480 | 192.168.11.23 |            815
                                                           Bloom filter allows skipping sstable 37432 | 06:30:52,480 | 192.168.11.23 |            857
                                                           Bloom filter allows skipping sstable 36918 | 06:30:52,480 | 192.168.11.23 |            866
                                                           Merging data from memtables and 0 sstables | 06:30:52,480 | 192.168.11.23 |            874
                                                                   Read 0 live and 0 tombstoned cells | 06:30:52,480 | 192.168.11.23 |            898
                                                                                     Request complete | 06:30:52,479 | 192.168.11.23 |            990

以上是 cassandra cqlsh 对单个查询的跟踪输出，但我无法理解一些条目，首先“source_elapsed”列是什么意思，是指执行特定任务所用的时间还是累计时间到这个任务。第二个“时间戳”不保持时间顺序，如“请求完成”时间戳是 06:30:52,479，但“合并来自 memtables 和 0 sstables 的数据”是 06:30:52,480，这应该发生得更早，但时间戳显示它发生得更晚。

也无法理解一些活动，

  1. 执行单分区查询——这不是将所有任务作为一个整体，还是一个起点？它包括哪些工作？为什么会重复三遍？它是否与复制因子有关。

  2. 获取 sstable 引用——这是什么意思，它是否检查所有 sstable 的布隆过滤器是否包含我们搜索的特定键？然后在“分区索引”的帮助下找到数据文件中的引用。

  3. 布隆过滤器允许跳过 sstable——什么时候发生？它是如何发生的？找到稳定的参考需要相同的时间。

  4. 请求完成——这是什么意思？是终点线还是需要花费最多时间的工作？

4

1 回答 1

4

您是否在 Cassandra链接中看到了解释不同跟踪场景的请求跟踪？

  1. source_elapsed: 是特定节点上的累计执行时间（如果你检查上面的链接会更清楚）
  2. Executing single-partition query：（似乎代表）开始时间
  3. Request complete: 已针对此请求完成所有工作

对于其余部分，您最好阅读Cassandra 文档中的 Reads，因为这比我在这里总结的要详细得多。

于 2013-09-24T09:20:06.773 回答