On Tuesday, April 4, 2017 at 7:51:58 AM UTC-7, Yang Chu wrote:
>
> I have an odd behavior that is consistently reproducible. A sequel query
> runs >20 sec in RSpec vs 1-2 sec in Cucumber framework. What can I do to
> further isolate the issue?
>
I would double check that they are running on the same database, and if
they are, that nothing else is going on in the database or the process at
the same time, but beyond that I'm not sure. You could try profiling and
see if that provides any additional insights.
Thanks,
Jeremy
>
> - sequel 4.44.0
> - mysql 5.7.17 homebrew
> - ruby 2.3.1
> - same Gemfile - same gems loaded and required
> - same Sequel connect parameters
> - same Sequel models
> - Sequel makes same SQL call in log
> - same target DB/table on localhost
>
> *Cucumber*
> Sequel::Model.db = Sequel.connect(:adapter=>'mysql2',
> :host=>params['host'],
> :user=>params['username'],
> :password=>params['password'],
> :database=>params['database'],
> :logger => Logger.new('log/db.log'))
> require_relative('../../models/mysql_models.rb')
> I, [2017-04-04T10:18:31.985907 #8119] INFO -- : (0.002462s) SET
> @@wait_timeout = 2147483
> I, [2017-04-04T10:18:31.988329 #8119] INFO -- : (0.002296s) SET
> SQL_AUTO_IS_NULL=0
> I, [2017-04-04T10:18:31.995527 #8119] INFO -- : (0.006837s) DESCRIBE
> `TST_Hotel_Master`
> I, [2017-04-04T10:18:32.006526 #8119] INFO -- : (0.004150s) DESCRIBE
> `HOTEL_PROVIDER`
> I, [2017-04-04T10:18:32.018764 #8119] INFO -- : (0.007097s) DESCRIBE
> `TST_Hotel_Photo_Sub`
> I, [2017-04-04T10:18:32.025964 #8119] INFO -- : (0.004370s) DESCRIBE
> `HOTEL_NOTICE`
> I, [2017-04-04T10:18:32.032684 #8119] INFO -- : (0.004056s) DESCRIBE
> `HOTEL_VENDOR`
> I, [2017-04-04T10:18:32.042064 #8119] INFO -- : (0.005833s) DESCRIBE
> `HOTEL_AMENITIES_MAP`
> I, [2017-04-04T10:18:32.048870 #8119] INFO -- : (0.004065s) DESCRIBE
> `HOTEL_AMENITIES`
> I, [2017-04-04T10:18:32.058001 #8119] INFO -- : (0.005569s) DESCRIBE
> `HOTEL_AMENITIES_OFFICIAL`
> I, [2017-04-04T10:18:32.065450 #8119] INFO -- : (0.004798s) DESCRIBE
> `CITIES`
> I, [2017-04-04T10:18:32.073952 #8119] INFO -- : (0.004590s) DESCRIBE
> `STATES`
> I, [2017-04-04T10:18:32.082867 #8119] INFO -- : (0.006935s) DESCRIBE
> `COUNTRIES`
> I, [2017-04-04T10:18:32.091720 #8119] INFO -- : (0.006064s) DESCRIBE
> `TDR_LANDMARKS`
> I, [2017-04-04T10:19:01.464728 #8119] INFO -- : (*28.198520s*) SELECT
> `hotel_id`, group_concat(distinct provider) AS `providers` FROM
> `HOTEL_PROVIDER` INNER JOIN `TST_Hotel_Master` AS `HotelMaster` ON
> (`HotelMaster`.`id` = `HOTEL_PROVIDER`.`hotel_id`) WHERE
> (`Property_Country_code` = 'US') GROUP BY `hotel_id` HAVING (count(distinct
> provider) >= 10) LIMIT 1
>
> *RSpec*
> Sequel::Model.db = Sequel.connect(:adapter=>'mysql2',
> :host=>data['host'],
> :user=>data['username'],
> :password=>data['password'],
> :database=>data['database'],
> :logger => Logger.new('log/db.log'))
> require_relative('../models/mysql_models.rb')
> I, [2017-04-04T10:23:50.474360 #8273] INFO -- : (0.000413s) SET
> @@wait_timeout = 2147483
> I, [2017-04-04T10:23:50.474774 #8273] INFO -- : (0.000328s) SET
> SQL_AUTO_IS_NULL=0
> I, [2017-04-04T10:23:50.475723 #8273] INFO -- : (0.000706s) DESCRIBE
> `TST_Hotel_Master`
> I, [2017-04-04T10:23:50.480887 #8273] INFO -- : (0.000645s) DESCRIBE
> `HOTEL_PROVIDER`
> I, [2017-04-04T10:23:50.483855 #8273] INFO -- : (0.000677s) DESCRIBE
> `TST_Hotel_Photo_Sub`
> I, [2017-04-04T10:23:50.486636 #8273] INFO -- : (0.000582s) DESCRIBE
> `HOTEL_NOTICE`
> I, [2017-04-04T10:23:50.488908 #8273] INFO -- : (0.000570s) DESCRIBE
> `HOTEL_VENDOR`
> I, [2017-04-04T10:23:50.491756 #8273] INFO -- : (0.000625s) DESCRIBE
> `HOTEL_AMENITIES_MAP`
> I, [2017-04-04T10:23:50.494278 #8273] INFO -- : (0.000643s) DESCRIBE
> `HOTEL_AMENITIES`
> I, [2017-04-04T10:23:50.497134 #8273] INFO -- : (0.000600s) DESCRIBE
> `HOTEL_AMENITIES_OFFICIAL`
> I, [2017-04-04T10:23:50.501429 #8273] INFO -- : (0.000692s) DESCRIBE
> `CITIES`
> I, [2017-04-04T10:23:50.504315 #8273] INFO -- : (0.000592s) DESCRIBE
> `STATES`
> I, [2017-04-04T10:23:50.506653 #8273] INFO -- : (0.000573s) DESCRIBE
> `COUNTRIES`
> I, [2017-04-04T10:23:50.509742 #8273] INFO -- : (0.000692s) DESCRIBE
> `TDR_LANDMARKS`
> I, [2017-04-04T09:23:56.474159 #8273] INFO -- : (*1.610943s*) SELECT
> `hotel_id`, group_concat(distinct provider) AS `providers` FROM
> `HOTEL_PROVIDER` INNER JOIN `TST_Hotel_Master` AS `HotelMaster` ON
> (`HotelMaster`.`id` = `HOTEL_PROVIDER`.`hotel_id`) WHERE
> (`Property_Country_code` = 'US') GROUP BY `hotel_id` HAVING (count(distinct
> provider) >= 10) LIMIT 1
>
--
You received this message because you are subscribed to the Google Groups
"sequel-talk" group.
To unsubscribe from this group and stop receiving emails from it, send an email
to [email protected].
To post to this group, send email to [email protected].
Visit this group at https://groups.google.com/group/sequel-talk.
For more options, visit https://groups.google.com/d/optout.
