| Sat Feb 20 17:05:12 JST 2021 |
| ruby 2.6.7p153 (2021-01-31 revision 67892) [x86_64-darwin19] |
| "execution expired\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `block in write'\n/usr/local/lib/ruby/2.6.0/monitor.rb:235:in `mon_synchronize'\n/usr/local/lib/ruby/2.6.0/logger.rb:686:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:471:in `add'\n/usr/local/lib/ruby/2.6.0/logger.rb:525:in `info'\nreproducible.rb:21:in `block in repeat_logging_until_timeout'\n/usr/local/lib/ruby/2.6.0/timeout.rb:108:in `timeout'\nreproducible.rb:19:in `repeat_logging_until_timeout'\nreproducible.rb:50:in `<main>'\n" |
| "main: mon_owned=false, mon_locked=false, mon_owner=" |
| "execution expired\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `block in write'\n/usr/local/lib/ruby/2.6.0/monitor.rb:235:in `mon_synchronize'\n/usr/local/lib/ruby/2.6.0/logger.rb:686:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:471:in `add'\n/usr/local/lib/ruby/2.6.0/logger.rb:525:in `info'\nreproducible.rb:21:in `block in repeat_logging_until_timeout'\n/usr/local/lib/ruby/2.6.0/timeout.rb:108:in `timeout'\nreproducible.rb:19:in `repeat_logging_until_timeout'\nreproducible.rb:50:in `<main>'\n" |
| "main: mon_owned=false, mon_locked=false, mon_owner=" |
| "execution expired\n/usr/local/lib/ruby/2.6.0/monitor.rb:237:in `handle_interrupt'\n/usr/local/lib/ruby/2.6.0/monitor.rb:237:in `mon_synchronize'\n/usr/local/lib/ruby/2.6.0/logger.rb:686:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:471:in `add'\n/usr/local/lib/ruby/2.6.0/logger.rb:525:in `info'\nreproducible.rb:21:in `block in repeat_logging_until_timeout'\n/usr/local/lib/ruby/2.6.0/timeout.rb:108:in `timeout'\nreproducible.rb:19:in `repeat_logging_until_timeout'\nreproducible.rb:50:in `<main>'\n" |
| "main: mon_owned=false, mon_locked=false, mon_owner=" |
| "execution expired\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:695:in `block in write'\n/usr/local/lib/ruby/2.6.0/monitor.rb:235:in `mon_synchronize'\n/usr/local/lib/ruby/2.6.0/logger.rb:686:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:471:in `add'\n/usr/local/lib/ruby/2.6.0/logger.rb:525:in `info'\nreproducible.rb:21:in `block in repeat_logging_until_timeout'\n/usr/local/lib/ruby/2.6.0/timeout.rb:108:in `timeout'\nreproducible.rb:19:in `repeat_logging_until_timeout'\nreproducible.rb:50:in `<main>'\n" |
| "main: mon_owned=false, mon_locked=false, mon_owner=" |
| "execution expired\n/usr/local/lib/ruby/2.6.0/monitor.rb:233:in `handle_interrupt'\n/usr/local/lib/ruby/2.6.0/monitor.rb:233:in `mon_synchronize'\n/usr/local/lib/ruby/2.6.0/logger.rb:686:in `write'\n/usr/local/lib/ruby/2.6.0/logger.rb:471:in `add'\n/usr/local/lib/ruby/2.6.0/logger.rb:525:in `info'\nreproducible.rb:21:in `block in repeat_logging_until_timeout'\n/usr/local/lib/ruby/2.6.0/timeout.rb:108:in `timeout'\nreproducible.rb:19:in `repeat_logging_until_timeout'\nreproducible.rb:50:in `<main>'\n" |
| "main: mon_owned=true, mon_locked=true, mon_owner=#<Thread:0x00007fc69c0640b8 run>" |
| "t: mon_owned=false, mon_locked=true, mon_owner=#<Thread:0x00007fc69c0640b8 sleep>" |
| I, [2021-02-20T17:05:17.348736 #46681] INFO -- : test |
| I, [2021-02-20T17:05:22.351874 #46681] INFO -- : t's backtrace is /usr/local/lib/ruby/2.6.0/monitor.rb:192:in `lock' |
| /usr/local/lib/ruby/2.6.0/monitor.rb:192:in `mon_enter' |
| /usr/local/lib/ruby/2.6.0/monitor.rb:233:in `block in mon_synchronize' |
| /usr/local/lib/ruby/2.6.0/monitor.rb:233:in `handle_interrupt' |
| /usr/local/lib/ruby/2.6.0/monitor.rb:233:in `mon_synchronize' |
| /usr/local/lib/ruby/2.6.0/logger.rb:686:in `write' |
| /usr/local/lib/ruby/2.6.0/logger.rb:471:in `add' |
| /usr/local/lib/ruby/2.6.0/logger.rb:525:in `info' |
| reproducible.rb:40:in `block in repeat_logging_until_timeout' |
| Sat Feb 20 17:05:22 JST 2021 |