Profile Report

Thread ID Total Time
202500 45.42

Thread 202500

%Total %Self Total Self Wait Child Calls Name Line
100.00% 0.00% 45.42 0.00 0.00 45.42 0 Global#[No method] 6
    45.42 0.00 0.00 45.42 1/1 <Class::ActiveRecord::Base>#find 6
    45.42 0.00 0.00 45.42 1/1 <Class::ActiveRecord::Base>#find 436
100.00% 0.00% 45.42 0.00 0.00 45.42 1 <Class::ActiveRecord::Base>#find_every 1023
    0.00 0.00 0.00 0.00 1/1 <Class::ActiveRecord::Base>#scoped? 1024
    0.00 0.00 0.00 0.00 2/1229886 Hash#[] 1028
    45.42 0.00 0.00 45.42 1/1 ActiveRecord::Associations::ClassMethods#find_with_associations 1024
    45.42 0.00 0.00 45.42 1/1 ActiveRecord::Associations::ClassMethods#find_with_associations 1123
100.00% 0.00% 45.42 0.00 0.00 45.42 1 Kernel#catch 0
    0.00 0.00 0.00 0.00 1/1 <Class::ActiveRecord::Base>#merge_includes 1124
    0.00 0.00 0.00 0.00 1/1118 Class#new 1124
    43.54 0.00 0.00 43.54 1/1 ActiveRecord::Associations::ClassMethods::JoinDependency#instantiate 1126
    0.00 0.00 0.00 0.00 2/1229886 Hash#[] 1124
    0.00 0.00 0.00 0.00 1/3 <Class::ActiveRecord::Base>#scope 1124
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::Associations::ClassMethods#select_all_rows 1125
    45.42 0.00 0.00 45.42 1/1 Global#[No method] 6
100.00% 0.00% 45.42 0.00 0.00 45.42 1 <Class::ActiveRecord::Base>#find 429
    0.00 0.00 0.00 0.00 2/1107 Symbol#=== 436
    0.00 0.00 0.00 0.00 1/1 Array#first 434
    0.00 0.00 0.00 0.00 1/1 <Class::ActiveRecord::Base>#set_readonly_option! 432
    45.42 0.00 0.00 45.42 1/1 <Class::ActiveRecord::Base>#find_every 436
    0.00 0.00 0.00 0.00 1/1 ActiveSupport::CoreExtensions::Array::ExtractOptions#extract_options! 430
    0.00 0.00 0.00 0.00 1/1 <Class::ActiveRecord::Base>#validate_find_options 431
    45.42 0.00 0.00 45.42 1/1 <Class::ActiveRecord::Base>#find_every 1024
100.00% 0.00% 45.42 0.00 0.00 45.42 1 ActiveRecord::Associations::ClassMethods#find_with_associations 1122
    45.42 0.00 0.00 45.42 1/1 Kernel#catch 1123
    0.01 0.01 0.00 0.00 1/6 Mysql#unpack_fields 431
    43.54 0.02 0.00 43.52 3/6 Enumerable#each_with_index 1398
    0.00 0.00 0.00 0.00 1/6 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinAssociation#association_join 1676
    0.00 0.00 0.00 0.00 1/6 ActiveRecord::Associations::ClassMethods::JoinDependency#build 1422
95.88% 0.07% 43.55 0.03 0.00 43.52 6 Array#each 0
    0.00 0.00 0.00 0.00 143/27695 Array#[] 456
    0.00 0.00 0.00 0.00 11/1115 Fixnum#to_s 1505
    0.00 0.00 0.00 0.00 1/1 ActiveRecord::Associations::ClassMethods::JoinDependency#build-1 1423
    0.06 0.02 0.00 0.04 1102/3307 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#record_id 1399
    0.02 0.01 0.00 0.01 1102/1103 ActiveRecord::Associations::ClassMethods::JoinDependency#join_associations 1403
    0.00 0.00 0.00 0.00 33/4485 Fixnum#+ 455
    43.40 0.05 0.00 43.35 1102/1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct 1403
    0.00 0.00 0.00 0.00 1/19846 Hash#[]= 1401
    0.00 0.00 0.00 0.00 11/1118 Class#new 460
    0.00 0.00 0.00 0.00 44/3392 Fixnum#* 455
    0.00 0.00 0.00 0.00 77/7889 String#[] 456
    0.00 0.00 0.00 0.00 1/14 ActiveRecord::Reflection::MacroReflection#options 1677
    0.02 0.02 0.00 0.00 2205/1229886 Hash#[] 1403
    0.00 0.00 0.00 0.00 1/1103 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#instantiate 1401
    0.01 0.01 0.00 0.00 1103/1103 ActiveRecord::Associations::ClassMethods::JoinDependency#join_base 1399
    0.00 0.00 0.00 0.00 5/2210 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#aliased_prefix 1505
    0.01 0.01 0.00 0.00 1102/1102 Kernel#dup 1403
    0.00 0.00 0.00 0.00 23/15556 Array#<< 1401
    0.00 0.00 0.00 0.00 2/3 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#column_names_with_alias 1504
    43.54 0.00 0.00 43.54 1/3 ActiveRecord::Associations::ClassMethods::JoinDependency#instantiate 1398
95.86% 0.00% 43.54 0.00 0.00 43.54 3 Enumerable#each_with_index 0
    43.54 0.02 0.00 43.52 3/6 Array#each 1398
    43.54 0.00 0.00 43.54 1/1 Kernel#catch 1126
95.86% 0.00% 43.54 0.00 0.00 43.54 1 ActiveRecord::Associations::ClassMethods::JoinDependency#instantiate 1397
    43.54 0.00 0.00 43.54 1/3 Enumerable#each_with_index 1398
    43.40 0.05 0.00 43.35 1102/1102 Array#each 1403
95.55% 0.11% 43.40 0.05 0.00 43.35 1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct 1435
    43.34 0.03 0.00 43.31 1102/1103 Array#each-1 1443
    0.01 0.01 0.00 0.00 3306/4426 Module#=== 1442
    0.00 0.00 0.00 0.00 1/1103 Enumerable#inject 1512
    43.34 0.03 0.00 43.31 1102/1103 ActiveRecord::Associations::ClassMethods::JoinDependency#construct 1443
95.42% 0.07% 43.34 0.03 0.00 43.31 1103 Array#each-1 0
    0.00 0.00 0.00 0.00 5/19846 Hash#[]= 1512
    43.31 0.03 0.00 43.28 1102/1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct-1 1444
    0.00 0.00 0.00 0.00 5/1229886 Hash#[] 1512
    43.31 0.03 0.00 43.28 1102/1102 Array#each-1 1444
95.35% 0.07% 43.31 0.03 0.00 43.28 1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct-1 1435
    43.24 0.07 0.00 43.17 1102/1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct_association 1441
    0.00 0.00 0.00 0.00 1102/2205 String#== 1438
    0.03 0.03 0.00 0.00 1102/3307 ActiveRecord::Reflection::MacroReflection#name 1438
    0.00 0.00 0.00 0.00 2204/3308 Symbol#to_s 1438
    0.01 0.01 0.00 0.00 1102/1102 Array#shift 1438
    0.00 0.00 0.00 0.00 1102/4426 Module#=== 1437
    43.24 0.07 0.00 43.17 1102/1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct-1 1441
95.20% 0.15% 43.24 0.07 0.00 43.17 1102 ActiveRecord::Associations::ClassMethods::JoinDependency#construct_association 1456
    42.75 1.56 0.00 41.19 1102/1104 Array#include? 1464
    0.00 0.00 0.00 0.00 1102/1115 Fixnum#to_s 1462
    0.00 0.00 0.00 0.00 1102/1102 Array#push 1464
    0.01 0.01 0.00 0.00 2204/2204 ActiveRecord::Associations::AssociationProxy#target 1464
    0.03 0.00 0.00 0.03 1102/3307 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#record_id 1462
    0.00 0.00 0.00 0.00 1102/1103 Kernel#nil? 1462
    0.00 0.00 0.00 0.00 1102/2205 String#== 1462
    0.00 0.00 0.00 0.00 1102/1106 String#to_s 1462
    0.03 0.02 0.00 0.01 1102/1103 Person(id: integer, name: string, address: text, created_at: datetime, updated_at: datetime)#id 1462
    0.00 0.00 0.00 0.00 1102/1102 ActiveRecord::Associations::AssociationProxy#loaded 1460
    0.00 0.00 0.00 0.00 1102/3307 ActiveRecord::Reflection::MacroReflection#name 1459
    0.00 0.00 0.00 0.00 1102/1108 ActiveRecord::Reflection::MacroReflection#macro 1457
    0.00 0.00 0.00 0.00 1102/1229886 Hash#[] 1462
    0.25 0.01 0.00 0.24 1102/1103 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#instantiate 1463
    0.01 0.01 0.00 0.00 1102/4409 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#aliased_primary_key 1462
    0.01 0.01 0.00 0.00 1102/1107 Symbol#=== 1458
    0.08 0.00 0.00 0.08 1102/2205 Kernel#send 1459
    42.75 1.56 0.00 41.19 1102/1104 ActiveRecord::Associations::ClassMethods::JoinDependency#construct_association 1464
    0.00 0.00 0.00 0.00 2/1104 Array#reject 1339
94.12% 3.43% 42.75 1.56 0.00 41.19 1104 Array#include? 0
    41.19 12.69 0.00 28.50 606651/606651 ActiveRecord::Base#== 1464
    0.00 0.00 0.00 0.00 4/14451 Kernel#== 1339
    41.19 12.69 0.00 28.50 606651/606651 Array#include? 1464
90.69% 27.94% 41.19 12.69 0.00 28.50 606651 ActiveRecord::Base#== 1958
    1.42 1.42 0.00 0.00 606651/686566 Fixnum#== 1961
    23.17 16.87 0.00 6.30 1213302/1213302 Item(id: integer, name: string, value: integer, person_id: integer, created_at: datetime, updated_at: datetime)#id 1961
    1.43 1.43 0.00 0.00 606651/606654 Kernel#class 1961
    1.32 1.32 0.00 0.00 606651/606651 Kernel#instance_of? 1961
    1.16 1.16 0.00 0.00 606651/606651 Kernel#equal? 1962
    23.17 16.87 0.00 6.30 1213302/1213302 ActiveRecord::Base#== 1961
51.01% 37.14% 23.17 16.87 0.00 6.30 1213302 Item(id: integer, name: string, value: integer, person_id: integer, created_at: datetime, updated_at: datetime)#id 160
    2.83 2.83 0.00 0.00 1213302/1214405 String#to_i 160
    3.47 3.47 0.00 0.00 1213302/1229886 Hash#[] 160
    0.02 0.02 0.00 0.00 2205/1229886 Array#each 1403
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency#build-1 1418
    0.00 0.00 0.00 0.00 5/1229886 Array#each-1 1512
    0.02 0.02 0.00 0.00 6612/1229886 Array#each-2 1512
    0.00 0.00 0.00 0.00 1102/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency#construct_association 1462
    0.02 0.02 0.00 0.00 3307/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#record_id 1516
    0.00 0.00 0.00 0.00 3/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinAssociation#association_join 1656
    3.47 3.47 0.00 0.00 1213302/1229886 Item(id: integer, name: string, value: integer, person_id: integer, created_at: datetime, updated_at: datetime)#id 160
    0.00 0.00 0.00 0.00 1/1229886 Class#read_inheritable_attribute 113
    0.01 0.01 0.00 0.00 1103/1229886 Person(id: integer, name: string, address: text, created_at: datetime, updated_at: datetime)#id 160
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Associations::AssociationProxy#initialize 12
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Reflection::AssociationReflection#through_reflection 149
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Associations::AssociationProxy#conditions 44
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Base#column_for_attribute 1954
    0.00 0.00 0.00 0.00 4/1229886 ActiveRecord::Associations::HasManyAssociation#construct_sql 158
    0.01 0.01 0.00 0.00 1103/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinBase#instantiate 1520
    0.00 0.00 0.00 0.00 1/1229886 <Class::ActiveRecord::Base>#add_joins! 1221
    0.00 0.00 0.00 0.00 1/1229886 <Class::ActiveRecord::Base>#set_readonly_option! 1690
    0.00 0.00 0.00 0.00 5/1229886 ActiveRecord::Associations::ClassMethods#construct_finder_sql_with_included_associations 1259
    0.00 0.00 0.00 0.00 2/1229886 Kernel#catch 1124
    0.00 0.00 0.00 0.00 2/1229886 <Class::ActiveRecord::Base>#find_every 1028
    0.00 0.00 0.00 0.00 14/1229886 <Class::ActiveRecord::Base>#connection 74
    0.00 0.00 0.00 0.00 4/1229886 ActiveRecord::Associations::ClassMethods::JoinDependency::JoinAssociation#initialize 1555
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::Reflection::AssociationReflection#check_validity! 173
    0.00 0.00 0.00 0.00 1103/1229886 <Class::ActiveRecord::Base>#instantiate 1096
    0.00 0.00 0.00 0.00 1/1229886 ActiveRecord::ConnectionAdapters::DatabaseStatements#add_lock! 121
7.82% 7.82% 3.55 3.55 0.00 0.00 1229886 Hash#[] 0
    0.00 0.00 0.00 0.00 2232/2232 Hash#default 1028
    2.83 2.83 0.00 0.00 1213302/1214405 Item(id: integer, name: string, value: integer, person_id: integer, created_at: datetime, updated_at: datetime)#id 160
    0.00 0.00 0.00 0.00 1103/1214405 Person(id: integer, name: string, address: text, created_at: datetime, updated_at: datetime)#id 160
6.23% 6.23% 2.83 2.83 0.00 0.00 1214405 String#to_i 0
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::Associations::ClassMethods#select_all_rows 1243
4.14% 0.00% 1.88 0.00 0.00 1.88 1 ActiveRecord::ConnectionAdapters::QueryCache#select_all 51
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::ConnectionAdapters::DatabaseStatements#select_all_without_query_cache 55
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::ConnectionAdapters::DatabaseStatements#select_all_without_query_cache 7
4.14% 0.00% 1.88 0.00 0.00 1.88 1 ActiveRecord::ConnectionAdapters::MysqlAdapter#select 479
    0.35 0.00 0.00 0.35 1/1 Mysql::Result#all_hashes 482
    0.00 0.00 0.00 0.00 1/1 Mysql::Result#free 483
    1.53 0.00 0.00 1.53 1/1 ActiveRecord::ConnectionAdapters::MysqlAdapter#execute 481
    1.88 0.00 0.00 1.88 1/1 Kernel#catch 1125
4.14% 0.00% 1.88 0.00 0.00 1.88 1 ActiveRecord::Associations::ClassMethods#select_all_rows 1242
    0.00 0.00 0.00 0.00 1/2 Module#name 1243
    0.00 0.00 0.00 0.00 1/1 ActiveRecord::Associations::ClassMethods#construct_finder_sql_with_included_associations 1243
    0.00 0.00 0.00 0.00 1/14 <Class::ActiveRecord::Base>#connection 1243
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::ConnectionAdapters::QueryCache#select_all 1243
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::ConnectionAdapters::QueryCache#select_all 55
4.14% 0.00% 1.88 0.00 0.00 1.88 1 ActiveRecord::ConnectionAdapters::DatabaseStatements#select_all_without_query_cache 6
    1.88 0.00 0.00 1.88 1/1 ActiveRecord::ConnectionAdapters::MysqlAdapter#select 7
    0.12 0.07 0.00 0.05 12199/686566 Integer#times 370
    0.00 0.00 0.00 0.00 1/686566 Mysql#query 326
    0.00 0.00 0.00 0.00 1116/686566 Mysql#read 515
    1.42 1.42 0.00 0.00 606651/686566 ActiveRecord::Base#== 1961
    0.01 0.01 0.00 0.00 3348/686566 Mysql::Net#read 1101
    0.00 0.00 0.00 0.00 11/686566 Mysql::Field#initialize 751
    0.07 0.07 0.00 0.00 12201/686566 Mysql#get_length 474
    0.09 0.09 0.00 0.00 48800/686566 Kernel#=== 485
    0.00 0.00 0.00 0.00 1/686566 Array#flatten 54
    0.00 0.00 0.00 0.00 1/686566 ActiveSupport::BufferedLogger#add 60
    0.00 0.00 0.00 0.00 3/686566 Mysql#read_query_result 423
    0.00 0.00 0.00 0.00 2234/686566 Mysql#read_one_row 364
3.76% 3.65% 1.71 1.66 0.00 0.05 686566 Fixnum#== 0
    0.05 0.05 0.00 0.00 13316/14451 Kernel#== 1093
    1.53 0.00 0.00 1.53 1/1 ActiveRecord::ConnectionAdapters::MysqlAdapter#execute 281
3.37% 0.00% 1.53 0.00 0.00 1.53 1 ActiveRecord::ConnectionAdapters::AbstractAdapter#log 128
    0.00 0.00 0.00 0.00 1/1 ActiveRecord::ConnectionAdapters::AbstractAdapter#log_info 134
    0.00 0.00 0.00 0.00 1/4 Float#+ 133
    0.00 0.00 0.00 0.00 1/12 Fixnum#<= 130
    0.00 0.00 0.00 0.00 1/1 Kernel#block_given? 129
    1.53 0.00 0.00 1.53 1/1 <Module::Benchmark>#realtime 132
    1.53 0.00 0.00 1.53 1/1 ActiveRecord::ConnectionAdapters::AbstractAdapter#log 132
3.37% 0.00% 1.53 0.00 0.00 1.53 1 <Module::Benchmark>#realtime 306
    1.53 0.00 0.00 1.53 1/1 <Module::Benchmark>#measure 307
    1.53 0.00 0.00 1.53 1/1 <Module::Benchmark>#realtime 307
3.37% 0.00% 1.53 0.00 0.00 1.53 1 <Module::Benchmark>#measure 291
    0.00 0.00 0.00 0.00 2/2 Struct::Tms#stime 295
    1.53 0.00 0.00 1.53 1/1 Mysql#query 281
    0.00 0.00 0.00 0.00 2/2 Struct::Tms#cutime 295
    0.00 0.00 0.00 0.00 1/1118 Class#new 295
    0.00 0.00 0.00 0.00 2/2 <Module::Benchmark>#times 294
    0.00 0.00 0.00 0.00 5/5 Float#- 295
    0.00 0.00 0.00 0.00 2/2 <Class::Time>#now 294
    0.00 0.00 0.00 0.00 2/2 Struct::Tms#cstime 295
    0.00 0.00 0.00 0.00 2/2 Time#to_f 295
    0.00 0.00 0.00 0.00 2/2 Struct::Tms#utime 295
    1.53 0.00 0.00 1.53 1/1 <Module::Benchmark>#measure 281
3.37% 0.00% 1.53 0.00 0.00 1.53 1 Mysql#query 321
    0.00 0.00 0.00 0.00 1/686566 Fixnum#== 326
    1.51 0.00 0.00 1.51 1/1 Mysql#store_result 329
    0.02 0.00 0.00 0.02 1/1 Mysql#real_query 322
    1.53 0.00 0.00 1.53 1/1 ActiveRecord::ConnectionAdapters::MysqlAdapter#select 481
3.37% 0.00% 1.53 0.00 0.00 1.53 1 ActiveRecord::ConnectionAdapters::MysqlAdapter#execute 280
    1.53 0.00 0.00 1.53 1/1 ActiveRecord::ConnectionAdapters::AbstractAdapter#log 281
    1.51 0.01 0.00 1.50 1/2 Mysql#store_result 212
    0.01 0.00 0.00 0.01 1/2 Mysql#read_query_result 421
3.35% 0.02% 1.52 0.01 0.00 1.51 2 Mysql#read_rows 465
    0.01 0.01 0.00 0.00 1113/15556 Array#<< 468
    1.50 0.04 0.00 1.46 1115/1115 Mysql#read_one_row 468
    1.51 0.00 0.00 1.51 1/1 Mysql#query 329
3.32% 0.00% 1.51 0.00 0.00 1.51 1 Mysql#store_result 207
    0.00 0.00 0.00 0.00 1/1118 Class#new 213
    1.51 0.01 0.00 1.50 1/2 Mysql#read_rows 212
    0.00 0.00 0.00 0.00 1/1106 Array#length 215
    0.00 0.00 0.00 0.00 1/14451 Kernel#== 208
    1.50 0.04 0.00 1.46 1115/1115 Mysql#read_rows 468
3.30% 0.09% 1.50 0.04 0.00 1.46 1115 Mysql#read_one_row 360
    1.30 0.17 0.00 1.13 1113/1113 Integer#times 368