events 1 (0.20μ) mysys/THR_LOCK_threads 2 (0.18μ) sql/THD::LOCK_thd_data 3 (0.24μ) sql/hash_filo::lock 4 (0.31μ) sql/LOGGER::LOCK_logger - read_lock 5 (0.08μ) sql/LOG::LOCK_log 6 (12.97μ) wait/io/file/sql/query_log - write 49 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/mysqld.log 7 (176.14μ) sql/select select @@version_comment limit 1 errors: 0 warnings: 0 lock time: 0.00μ rows affected: 0 rows sent: 1 rows examined: 0 tmp tables: 0 tmp disk tables: 0 select scan: 0 select full join: 0 select full range join: 0 select range: 0 select range check: 0 sort merge passes: 0 sort rows: 0 sort range: 0 sort scan: 0 no index used: FALSE no good index used: FALSE 8 (64.67μ) sql/init 7->8 16 (2.81μ) sql/checking permissions 7->16 17 (5.74μ) sql/Opening tables 7->17 18 (48.24μ) sql/init 7->18 20 (3.08μ) sql/optimizing 7->20 21 (14.45μ) sql/executing 7->21 23 (2.73μ) sql/end 7->23 24 (1.20μ) sql/query end 7->24 25 (1.32μ) sql/closing tables 7->25 26 (11.38μ) sql/freeing items 7->26 27 (17.02μ) sql/cleaning up 7->27 9 (0.25μ) sql/THD::LOCK_thd_data 8->9 10 (0.09μ) sql/THD::LOCK_thd_data 8->10 11 (0.24μ) sql/LOGGER::LOCK_logger - read_lock 8->11 12 (0.07μ) sql/LOG::LOCK_log 8->12 13 (7.13μ) wait/io/file/sql/query_log - write 47 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/mysqld.log 8->13 14 (0.23μ) sql/LOCK_plugin 8->14 15 (0.33μ) sql/LOCK_system_variables_hash - read_lock 8->15 19 (0.10μ) sql/LOCK_global_system_variables 18->19 22 (0.26μ) sql/LOCK_global_system_variables 21->22 28 (0.18μ) sql/THD::LOCK_thd_data 27->28 29 (1086.16μ) sql/delete DELETE FROM test.t1 WHERE i = 1 errors: 0 warnings: 0 lock time: 155.00μ rows affected: 1 rows sent: 0 rows examined: 1 tmp tables: 0 tmp disk tables: 0 select scan: 0 select full join: 0 select full range join: 0 select range: 0 select range check: 0 sort merge passes: 0 sort rows: 0 sort range: 0 sort scan: 0 no index used: FALSE no good index used: FALSE 30 (93.21μ) sql/init 29->30 36 (8.39μ) sql/checking permissions 29->36 38 (46.69μ) sql/Opening tables 29->38 56 (9.36μ) sql/System lock 29->56 60 (123.54μ) sql/init 29->60 77 (227.71μ) sql/updating 29->77 240 (7.77μ) sql/end 29->240 243 (310.89μ) sql/query end 29->243 288 (11.76μ) sql/closing tables 29->288 295 (18.34μ) sql/freeing items 29->295 296 (2.25μ) sql/cleaning up 29->296 31 (0.78μ) sql/THD::LOCK_thd_data 30->31 32 (0.12μ) sql/THD::LOCK_thd_data 30->32 33 (0.57μ) sql/LOGGER::LOCK_logger - read_lock 30->33 34 (0.09μ) sql/LOG::LOCK_log 30->34 35 (17.49μ) wait/io/file/sql/query_log - write 60 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/mysqld.log 30->35 37 (0.43μ) sql/LOCK_grant - read_lock 36->37 39 (0.29μ) sql/MDL_lock::rwlock - write_lock 38->39 40 (0.13μ) sql/MDL_map::mutex 38->40 41 (0.10μ) sql/MDL_lock::rwlock - write_lock 38->41 42 (0.10μ) sql/LOCK_open 38->42 43 (0.12μ) sql/THD::LOCK_thd_data 38->43 44 (0.22μ) innodb/os_mutex 38->44 45 (0.08μ) innodb/os_mutex 38->45 46 (0.08μ) innodb/os_mutex 38->46 47 (0.42μ) innodb/mutex_list_mutex 38->47 48 (0.08μ) innodb/os_mutex 38->48 49 (0.08μ) innodb/os_mutex 38->49 50 (0.08μ) innodb/os_mutex 38->50 51 (0.08μ) innodb/mutex_list_mutex 38->51 52 (2.59μ) innodb/trx_sys_lock - write_lock 38->52 55 (0.19μ) innodb/rw_lock_mutex 38->55 57 (1.82μ) sql/handler - write external Object: test.t1 Index: i 38->57 58 (1.69μ) sql/handler - write allow write Object: test.t1 Index: i 38->58 53 (0.26μ) innodb/rw_lock_mutex 52->53 54 (0.20μ) innodb/rw_lock_mutex 52->54 59 (0.09μ) mysys/THR_LOCK::mutex 58->59 61 (0.31μ) innodb/rw_lock_mutex 60->61 62 (0.25μ) innodb/rw_lock_mutex 60->62 63 (0.09μ) innodb/rw_lock_mutex 60->63 64 (0.08μ) innodb/rw_lock_mutex 60->64 65 (0.08μ) innodb/rw_lock_mutex 60->65 66 (0.09μ) innodb/rw_lock_mutex 60->66 67 (0.22μ) innodb/rw_lock_mutex 60->67 68 (0.20μ) innodb/rw_lock_mutex 60->68 69 (0.09μ) innodb/rw_lock_mutex 60->69 70 (0.10μ) innodb/rw_lock_mutex 60->70 71 (0.09μ) innodb/rw_lock_mutex 60->71 72 (0.08μ) innodb/rw_lock_mutex 60->72 73 (0.08μ) innodb/rw_lock_mutex 60->73 74 (0.08μ) innodb/rw_lock_mutex 60->74 75 (0.08μ) innodb/rw_lock_mutex 60->75 76 (0.08μ) innodb/rw_lock_mutex 60->76 78 (43.52μ) wait/io/table/sql/handler - fetch Object: test.t1 Index: i 60->78 112 (150.51μ) wait/io/table/sql/handler - delete Object: test.t1 60->112 214 (24.47μ) wait/io/table/sql/handler - fetch Object: test.t1 Index: i 60->214 79 (1.72μ) innodb/trx_sys_lock - write_lock 78->79 82 (0.11μ) innodb/rw_lock_mutex 78->82 83 (0.25μ) innodb/lock_mutex 78->83 84 (0.09μ) innodb/trx_mutex 78->84 85 (0.10μ) innodb/rw_lock_mutex 78->85 86 (0.10μ) innodb/rw_lock_mutex 78->86 87 (0.08μ) innodb/rw_lock_mutex 78->87 88 (0.09μ) innodb/rw_lock_mutex 78->88 89 (0.08μ) innodb/rw_lock_mutex 78->89 90 (0.08μ) innodb/rw_lock_mutex 78->90 91 (0.08μ) innodb/rw_lock_mutex 78->91 92 (0.86μ) innodb/trx_sys_lock - read_lock 78->92 94 (0.08μ) innodb/rw_lock_mutex 78->94 95 (0.09μ) innodb/lock_mutex 78->95 96 (0.08μ) innodb/trx_mutex 78->96 97 (0.09μ) innodb/rw_lock_mutex 78->97 98 (0.20μ) innodb/rw_lock_mutex 78->98 99 (0.08μ) innodb/rw_lock_mutex 78->99 100 (0.08μ) innodb/rw_lock_mutex 78->100 101 (0.08μ) innodb/rw_lock_mutex 78->101 102 (0.09μ) innodb/rw_lock_mutex 78->102 103 (0.08μ) innodb/rw_lock_mutex 78->103 104 (0.08μ) innodb/lock_mutex 78->104 105 (0.71μ) innodb/trx_sys_lock - read_lock 78->105 107 (0.08μ) innodb/rw_lock_mutex 78->107 108 (0.08μ) innodb/lock_mutex 78->108 109 (0.08μ) innodb/trx_mutex 78->109 110 (0.09μ) innodb/rw_lock_mutex 78->110 111 (0.08μ) innodb/rw_lock_mutex 78->111 80 (0.18μ) innodb/rw_lock_mutex 79->80 81 (0.10μ) innodb/rw_lock_mutex 79->81 93 (0.09μ) innodb/rw_lock_mutex 92->93 106 (0.09μ) innodb/rw_lock_mutex 105->106 113 (0.09μ) innodb/rw_lock_mutex 112->113 114 (0.08μ) innodb/rw_lock_mutex 112->114 115 (0.22μ) innodb/trx_undo_mutex 112->115 116 (0.21μ) innodb/rseg_mutex 112->116 117 (0.09μ) innodb/rw_lock_mutex 112->117 118 (0.08μ) innodb/rw_lock_mutex 112->118 119 (0.09μ) innodb/rw_lock_mutex 112->119 120 (0.09μ) innodb/rw_lock_mutex 112->120 121 (0.25μ) innodb/fil_system_mutex 112->121 122 (0.09μ) innodb/rw_lock_mutex 112->122 123 (0.08μ) innodb/rw_lock_mutex 112->123 124 (0.09μ) innodb/rw_lock_mutex 112->124 125 (0.08μ) innodb/rw_lock_mutex 112->125 126 (0.09μ) innodb/rw_lock_mutex 112->126 127 (0.08μ) innodb/rw_lock_mutex 112->127 128 (0.17μ) innodb/fil_system_mutex 112->128 129 (0.08μ) innodb/fil_system_mutex 112->129 130 (0.08μ) innodb/rw_lock_mutex 112->130 131 (0.08μ) innodb/rw_lock_mutex 112->131 132 (0.08μ) innodb/rw_lock_mutex 112->132 133 (0.09μ) innodb/rw_lock_mutex 112->133 134 (0.08μ) innodb/rw_lock_mutex 112->134 135 (0.09μ) innodb/rw_lock_mutex 112->135 136 (0.09μ) innodb/rw_lock_mutex 112->136 137 (0.08μ) innodb/rw_lock_mutex 112->137 138 (0.20μ) innodb/rw_lock_mutex 112->138 139 (0.09μ) innodb/rw_lock_mutex 112->139 140 (0.08μ) innodb/rw_lock_mutex 112->140 141 (0.08μ) innodb/rw_lock_mutex 112->141 142 (0.08μ) innodb/rw_lock_mutex 112->142 143 (0.08μ) innodb/rw_lock_mutex 112->143 144 (0.08μ) innodb/rw_lock_mutex 112->144 145 (0.08μ) innodb/rw_lock_mutex 112->145 146 (0.09μ) innodb/rw_lock_mutex 112->146 147 (0.14μ) innodb/buf_pool_mutex 112->147 148 (0.08μ) innodb/buf_pool_mutex 112->148 149 (0.09μ) innodb/rw_lock_mutex 112->149 150 (0.09μ) innodb/rw_lock_mutex 112->150 151 (0.09μ) innodb/rw_lock_mutex 112->151 152 (0.21μ) innodb/fil_system_mutex 112->152 153 (0.09μ) innodb/rw_lock_mutex 112->153 154 (0.08μ) innodb/rw_lock_mutex 112->154 155 (0.09μ) innodb/rw_lock_mutex 112->155 156 (0.25μ) innodb/rw_lock_mutex 112->156 157 (0.11μ) innodb/rw_lock_mutex 112->157 158 (0.11μ) innodb/fil_system_mutex 112->158 159 (0.20μ) innodb/buf_pool_mutex 112->159 160 (0.26μ) innodb/rw_lock_mutex 112->160 161 (0.08μ) innodb/rw_lock_mutex 112->161 162 (0.08μ) innodb/rw_lock_mutex 112->162 163 (0.09μ) innodb/rw_lock_mutex 112->163 164 (0.20μ) innodb/rw_lock_mutex 112->164 165 (0.08μ) innodb/rw_lock_mutex 112->165 166 (0.08μ) innodb/rw_lock_mutex 112->166 167 (0.08μ) innodb/rw_lock_mutex 112->167 168 (0.08μ) innodb/rw_lock_mutex 112->168 169 (0.13μ) innodb/fil_system_mutex 112->169 170 (0.14μ) innodb/log_sys_mutex 112->170 171 (0.15μ) innodb/log_flush_order_mutex 112->171 172 (0.20μ) innodb/flush_list_mutex 112->172 173 (0.08μ) innodb/flush_list_mutex 112->173 174 (0.09μ) innodb/flush_list_mutex 112->174 175 (0.09μ) innodb/flush_list_mutex 112->175 176 (0.09μ) innodb/rw_lock_mutex 112->176 177 (0.08μ) innodb/rw_lock_mutex 112->177 178 (0.08μ) innodb/rw_lock_mutex 112->178 179 (0.09μ) innodb/rw_lock_mutex 112->179 180 (0.09μ) innodb/rw_lock_mutex 112->180 181 (0.12μ) innodb/rw_lock_mutex 112->181 182 (0.08μ) innodb/rw_lock_mutex 112->182 183 (0.10μ) innodb/rw_lock_mutex 112->183 184 (0.09μ) innodb/rw_lock_mutex 112->184 185 (0.08μ) innodb/rw_lock_mutex 112->185 186 (0.09μ) innodb/rw_lock_mutex 112->186 187 (0.08μ) innodb/rw_lock_mutex 112->187 188 (0.08μ) innodb/rw_lock_mutex 112->188 189 (0.09μ) innodb/rw_lock_mutex 112->189 190 (0.14μ) innodb/rw_lock_mutex 112->190 191 (0.22μ) innodb/log_sys_mutex 112->191 192 (0.08μ) innodb/log_sys_mutex 112->192 193 (0.08μ) innodb/log_flush_order_mutex 112->193 194 (0.08μ) innodb/rw_lock_mutex 112->194 195 (0.08μ) innodb/log_sys_mutex 112->195 196 (0.08μ) innodb/log_flush_order_mutex 112->196 197 (0.10μ) innodb/flush_list_mutex 112->197 198 (0.09μ) innodb/rw_lock_mutex 112->198 199 (0.11μ) innodb/rw_lock_mutex 112->199 200 (0.09μ) innodb/rw_lock_mutex 112->200 201 (0.08μ) innodb/rw_lock_mutex 112->201 202 (0.08μ) innodb/rw_lock_mutex 112->202 203 (0.08μ) innodb/rw_lock_mutex 112->203 204 (0.09μ) innodb/rw_lock_mutex 112->204 205 (0.09μ) innodb/rw_lock_mutex 112->205 206 (0.10μ) innodb/rw_lock_mutex 112->206 207 (0.09μ) innodb/lock_mutex 112->207 208 (0.09μ) innodb/trx_mutex 112->208 209 (0.08μ) innodb/trx_mutex 112->209 210 (0.11μ) innodb/log_sys_mutex 112->210 211 (0.08μ) innodb/log_flush_order_mutex 112->211 212 (0.09μ) innodb/flush_list_mutex 112->212 213 (0.09μ) innodb/rw_lock_mutex 112->213 215 (0.08μ) innodb/rw_lock_mutex 214->215 216 (0.74μ) innodb/trx_sys_lock - read_lock 214->216 218 (0.08μ) innodb/rw_lock_mutex 214->218 219 (0.73μ) innodb/trx_sys_lock - read_lock 214->219 221 (0.08μ) innodb/rw_lock_mutex 214->221 222 (0.62μ) innodb/trx_sys_lock - read_lock 214->222 224 (0.12μ) innodb/rw_lock_mutex 214->224 225 (0.11μ) innodb/rw_lock_mutex 214->225 226 (0.09μ) innodb/rw_lock_mutex 214->226 227 (0.08μ) innodb/rw_lock_mutex 214->227 228 (0.08μ) innodb/rw_lock_mutex 214->228 229 (0.08μ) innodb/rw_lock_mutex 214->229 230 (0.08μ) innodb/rw_lock_mutex 214->230 231 (0.15μ) innodb/rw_lock_mutex 214->231 232 (0.79μ) innodb/trx_sys_lock - read_lock 214->232 234 (0.22μ) innodb/rw_lock_mutex 214->234 235 (0.08μ) innodb/rw_lock_mutex 214->235 236 (0.09μ) innodb/lock_mutex 214->236 237 (0.08μ) innodb/trx_mutex 214->237 238 (0.08μ) innodb/trx_mutex 214->238 239 (0.08μ) innodb/rw_lock_mutex 214->239 217 (0.10μ) innodb/rw_lock_mutex 216->217 220 (0.08μ) innodb/rw_lock_mutex 219->220 223 (0.08μ) innodb/rw_lock_mutex 222->223 233 (0.19μ) innodb/rw_lock_mutex 232->233 241 (0.14μ) sql/Query_cache::structure_guard_mutex 240->241 242 (0.09μ) sql/Query_cache::structure_guard_mutex 240->242 244 (0.19μ) sql/MDL_lock::rwlock - write_lock 243->244 245 (0.23μ) innodb/rseg_mutex 243->245 246 (1.24μ) innodb/trx_sys_lock - write_lock 243->246 249 (0.21μ) innodb/purge_sys_bh_mutex 243->249 250 (0.12μ) innodb/rw_lock_mutex 243->250 251 (0.11μ) innodb/rw_lock_mutex 243->251 252 (0.09μ) innodb/rw_lock_mutex 243->252 253 (0.09μ) innodb/rw_lock_mutex 243->253 254 (0.09μ) innodb/rw_lock_mutex 243->254 255 (0.10μ) innodb/rw_lock_mutex 243->255 256 (0.08μ) innodb/rw_lock_mutex 243->256 257 (0.10μ) innodb/rw_lock_mutex 243->257 258 (0.08μ) innodb/rw_lock_mutex 243->258 259 (1.07μ) innodb/trx_sys_lock - write_lock 243->259 262 (0.12μ) innodb/rw_lock_mutex 243->262 263 (0.12μ) innodb/log_sys_mutex 243->263 264 (0.09μ) innodb/log_flush_order_mutex 243->264 265 (0.09μ) innodb/rw_lock_mutex 243->265 266 (0.08μ) innodb/rw_lock_mutex 243->266 267 (0.10μ) innodb/lock_mutex 243->267 268 (0.08μ) innodb/trx_mutex 243->268 269 (0.77μ) innodb/trx_sys_lock - read_lock 243->269 271 (0.08μ) innodb/rw_lock_mutex 243->271 272 (1.03μ) innodb/trx_sys_lock - write_lock 243->272 275 (0.20μ) innodb/rw_lock_mutex 243->275 276 (0.22μ) innodb/log_sys_mutex 243->276 277 (0.22μ) innodb/fil_system_mutex 243->277 278 (21.48μ) wait/io/file/innodb/innodb_log_file - write 1536 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 243->278 282 (0.29μ) innodb/fil_system_mutex 243->282 283 (0.22μ) innodb/fil_system_mutex 243->283 284 (232.70μ) wait/io/file/innodb/innodb_log_file - sync /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 243->284 285 (0.39μ) innodb/fil_system_mutex 243->285 286 (0.15μ) innodb/log_sys_mutex 243->286 287 (0.17μ) sql/MDL_lock::rwlock - write_lock 243->287 247 (0.09μ) innodb/rw_lock_mutex 246->247 248 (0.08μ) innodb/rw_lock_mutex 246->248 260 (0.09μ) innodb/rw_lock_mutex 259->260 261 (0.09μ) innodb/rw_lock_mutex 259->261 270 (0.09μ) innodb/rw_lock_mutex 269->270 273 (0.08μ) innodb/rw_lock_mutex 272->273 274 (0.08μ) innodb/rw_lock_mutex 272->274 279 (20.58μ) wait/io/file/innodb/innodb_log_file - write 1536 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 278->279 280 (0.22μ) innodb/os_mutex 279->280 281 (0.31μ) innodb/os_mutex 279->281 289 (0.11μ) mysys/THR_LOCK::mutex 288->289 290 (0.11μ) sql/THD::LOCK_thd_data 288->290 291 (0.09μ) sql/LOCK_open 288->291 292 (0.09μ) sql/MDL_lock::rwlock - write_lock 288->292 293 (0.09μ) sql/MDL_lock::rwlock - write_lock 288->293 294 (0.11μ) sql/MDL_map::mutex 288->294 297 (0.23μ) sql/THD::LOCK_thd_data 296->297 298 (2011.59μ) sql/delete DELETE FROM test.t1 WHERE j = 8 errors: 0 warnings: 0 lock time: 137.00μ rows affected: 1 rows sent: 0 rows examined: 4 tmp tables: 0 tmp disk tables: 0 select scan: 0 select full join: 0 select full range join: 0 select range: 0 select range check: 0 sort merge passes: 0 sort rows: 0 sort range: 0 sort scan: 0 no index used: FALSE no good index used: FALSE 299 (89.62μ) sql/init 298->299 305 (8.69μ) sql/checking permissions 298->305 307 (31.83μ) sql/Opening tables 298->307 313 (9.65μ) sql/System lock 298->313 317 (33.32μ) sql/init 298->317 318 (240.25μ) sql/updating 298->318 472 (6.04μ) sql/end 298->472 475 (800.32μ) sql/query end 298->475 520 (11.95μ) sql/closing tables 298->520 527 (18.85μ) sql/freeing items 298->527 528 (2.17μ) sql/cleaning up 298->528 300 (0.76μ) sql/THD::LOCK_thd_data 299->300 301 (0.13μ) sql/THD::LOCK_thd_data 299->301 302 (0.59μ) sql/LOGGER::LOCK_logger - read_lock 299->302 303 (0.09μ) sql/LOG::LOCK_log 299->303 304 (17.55μ) wait/io/file/sql/query_log - write 60 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/mysqld.log 299->304 306 (0.45μ) sql/LOCK_grant - read_lock 305->306 308 (0.29μ) sql/MDL_lock::rwlock - write_lock 307->308 309 (0.12μ) sql/MDL_map::mutex 307->309 310 (0.11μ) sql/MDL_lock::rwlock - write_lock 307->310 311 (0.09μ) sql/LOCK_open 307->311 312 (0.11μ) sql/THD::LOCK_thd_data 307->312 314 (1.47μ) sql/handler - write external Object: test.t1 Index: i 307->314 315 (1.81μ) sql/handler - write allow write Object: test.t1 Index: i 307->315 319 (41.92μ) wait/io/table/sql/handler - fetch Object: test.t1 307->319 340 (7.74μ) wait/io/table/sql/handler - fetch Object: test.t1 307->340 349 (4.98μ) wait/io/table/sql/handler - fetch Object: test.t1 307->349 358 (165.48μ) wait/io/table/sql/handler - delete Object: test.t1 307->358 458 (7.11μ) wait/io/table/sql/handler - fetch Object: test.t1 307->458 467 (4.08μ) wait/io/table/sql/handler - fetch Object: test.t1 307->467 316 (0.13μ) mysys/THR_LOCK::mutex 315->316 320 (3.96μ) innodb/trx_sys_lock - write_lock 319->320 323 (0.11μ) innodb/rw_lock_mutex 319->323 324 (0.24μ) innodb/lock_mutex 319->324 325 (0.09μ) innodb/trx_mutex 319->325 326 (0.45μ) innodb/rw_lock_mutex 319->326 327 (0.27μ) innodb/rw_lock_mutex 319->327 328 (0.09μ) innodb/rw_lock_mutex 319->328 329 (0.09μ) innodb/rw_lock_mutex 319->329 330 (0.08μ) innodb/rw_lock_mutex 319->330 331 (0.09μ) innodb/rw_lock_mutex 319->331 332 (0.11μ) innodb/rw_lock_mutex 319->332 333 (0.09μ) innodb/lock_mutex 319->333 334 (0.66μ) innodb/trx_sys_lock - read_lock 319->334 336 (0.09μ) innodb/rw_lock_mutex 319->336 337 (0.09μ) innodb/lock_mutex 319->337 338 (0.08μ) innodb/trx_mutex 319->338 339 (0.10μ) innodb/rw_lock_mutex 319->339 321 (0.73μ) innodb/rw_lock_mutex 320->321 322 (0.23μ) innodb/rw_lock_mutex 320->322 335 (0.09μ) innodb/rw_lock_mutex 334->335 341 (0.09μ) innodb/rw_lock_mutex 340->341 342 (0.08μ) innodb/lock_mutex 340->342 343 (0.55μ) innodb/trx_sys_lock - read_lock 340->343 345 (0.09μ) innodb/rw_lock_mutex 340->345 346 (0.08μ) innodb/lock_mutex 340->346 347 (0.08μ) innodb/trx_mutex 340->347 348 (0.08μ) innodb/rw_lock_mutex 340->348 344 (0.08μ) innodb/rw_lock_mutex 343->344 350 (0.08μ) innodb/rw_lock_mutex 349->350 351 (0.08μ) innodb/lock_mutex 349->351 352 (0.55μ) innodb/trx_sys_lock - read_lock 349->352 354 (0.08μ) innodb/rw_lock_mutex 349->354 355 (0.08μ) innodb/lock_mutex 349->355 356 (0.08μ) innodb/trx_mutex 349->356 357 (0.08μ) innodb/rw_lock_mutex 349->357 353 (0.10μ) innodb/rw_lock_mutex 352->353 359 (0.08μ) innodb/rw_lock_mutex 358->359 360 (0.08μ) innodb/rw_lock_mutex 358->360 361 (0.20μ) innodb/trx_undo_mutex 358->361 362 (0.22μ) innodb/rseg_mutex 358->362 363 (0.09μ) innodb/rw_lock_mutex 358->363 364 (0.08μ) innodb/rw_lock_mutex 358->364 365 (0.09μ) innodb/rw_lock_mutex 358->365 366 (0.10μ) innodb/rw_lock_mutex 358->366 367 (0.26μ) innodb/fil_system_mutex 358->367 368 (0.09μ) innodb/rw_lock_mutex 358->368 369 (0.08μ) innodb/rw_lock_mutex 358->369 370 (0.31μ) innodb/rw_lock_mutex 358->370 371 (0.09μ) innodb/rw_lock_mutex 358->371 372 (0.09μ) innodb/rw_lock_mutex 358->372 373 (0.08μ) innodb/rw_lock_mutex 358->373 374 (0.20μ) innodb/fil_system_mutex 358->374 375 (0.09μ) innodb/fil_system_mutex 358->375 376 (0.09μ) innodb/rw_lock_mutex 358->376 377 (0.08μ) innodb/rw_lock_mutex 358->377 378 (0.08μ) innodb/rw_lock_mutex 358->378 379 (0.08μ) innodb/rw_lock_mutex 358->379 380 (0.08μ) innodb/rw_lock_mutex 358->380 381 (0.08μ) innodb/rw_lock_mutex 358->381 382 (0.09μ) innodb/rw_lock_mutex 358->382 383 (0.08μ) innodb/rw_lock_mutex 358->383 384 (0.14μ) innodb/rw_lock_mutex 358->384 385 (0.08μ) innodb/rw_lock_mutex 358->385 386 (0.08μ) innodb/rw_lock_mutex 358->386 387 (0.08μ) innodb/rw_lock_mutex 358->387 388 (0.08μ) innodb/rw_lock_mutex 358->388 389 (0.08μ) innodb/rw_lock_mutex 358->389 390 (0.08μ) innodb/rw_lock_mutex 358->390 391 (0.08μ) innodb/rw_lock_mutex 358->391 392 (0.08μ) innodb/rw_lock_mutex 358->392 393 (0.13μ) innodb/buf_pool_mutex 358->393 394 (0.08μ) innodb/buf_pool_mutex 358->394 395 (0.09μ) innodb/rw_lock_mutex 358->395 396 (0.08μ) innodb/rw_lock_mutex 358->396 397 (0.08μ) innodb/rw_lock_mutex 358->397 398 (0.21μ) innodb/fil_system_mutex 358->398 399 (0.09μ) innodb/rw_lock_mutex 358->399 400 (0.08μ) innodb/rw_lock_mutex 358->400 401 (0.09μ) innodb/rw_lock_mutex 358->401 402 (0.08μ) innodb/rw_lock_mutex 358->402 403 (0.10μ) innodb/rw_lock_mutex 358->403 404 (0.12μ) innodb/fil_system_mutex 358->404 405 (0.25μ) innodb/buf_pool_mutex 358->405 406 (0.29μ) innodb/rw_lock_mutex 358->406 407 (0.08μ) innodb/rw_lock_mutex 358->407 408 (0.09μ) innodb/rw_lock_mutex 358->408 409 (0.09μ) innodb/rw_lock_mutex 358->409 410 (0.22μ) innodb/rw_lock_mutex 358->410 411 (0.08μ) innodb/rw_lock_mutex 358->411 412 (0.08μ) innodb/rw_lock_mutex 358->412 413 (0.08μ) innodb/rw_lock_mutex 358->413 414 (0.10μ) innodb/rw_lock_mutex 358->414 415 (0.14μ) innodb/fil_system_mutex 358->415 416 (0.13μ) innodb/log_sys_mutex 358->416 417 (0.15μ) innodb/log_flush_order_mutex 358->417 418 (0.22μ) innodb/flush_list_mutex 358->418 419 (0.08μ) innodb/flush_list_mutex 358->419 420 (0.09μ) innodb/flush_list_mutex 358->420 421 (0.08μ) innodb/flush_list_mutex 358->421 422 (0.08μ) innodb/rw_lock_mutex 358->422 423 (0.09μ) innodb/rw_lock_mutex 358->423 424 (0.08μ) innodb/rw_lock_mutex 358->424 425 (0.09μ) innodb/rw_lock_mutex 358->425 426 (0.08μ) innodb/rw_lock_mutex 358->426 427 (0.12μ) innodb/rw_lock_mutex 358->427 428 (0.08μ) innodb/rw_lock_mutex 358->428 429 (0.11μ) innodb/rw_lock_mutex 358->429 430 (0.09μ) innodb/rw_lock_mutex 358->430 431 (0.08μ) innodb/rw_lock_mutex 358->431 432 (0.08μ) innodb/rw_lock_mutex 358->432 433 (0.09μ) innodb/rw_lock_mutex 358->433 434 (0.08μ) innodb/rw_lock_mutex 358->434 435 (0.09μ) innodb/rw_lock_mutex 358->435 436 (0.10μ) innodb/rw_lock_mutex 358->436 437 (0.22μ) innodb/log_sys_mutex 358->437 438 (0.08μ) innodb/log_flush_order_mutex 358->438 439 (0.09μ) innodb/rw_lock_mutex 358->439 440 (0.14μ) innodb/log_sys_mutex 358->440 441 (0.09μ) innodb/log_sys_mutex 358->441 442 (0.08μ) innodb/log_flush_order_mutex 358->442 443 (0.10μ) innodb/flush_list_mutex 358->443 444 (0.09μ) innodb/rw_lock_mutex 358->444 445 (0.15μ) innodb/rw_lock_mutex 358->445 446 (0.09μ) innodb/rw_lock_mutex 358->446 447 (0.08μ) innodb/rw_lock_mutex 358->447 448 (0.08μ) innodb/rw_lock_mutex 358->448 449 (0.08μ) innodb/rw_lock_mutex 358->449 450 (0.09μ) innodb/rw_lock_mutex 358->450 451 (0.08μ) innodb/rw_lock_mutex 358->451 452 (0.22μ) innodb/rw_lock_mutex 358->452 453 (0.09μ) innodb/lock_mutex 358->453 454 (0.09μ) innodb/log_sys_mutex 358->454 455 (0.09μ) innodb/log_flush_order_mutex 358->455 456 (0.10μ) innodb/flush_list_mutex 358->456 457 (0.09μ) innodb/rw_lock_mutex 358->457 459 (0.09μ) innodb/rw_lock_mutex 458->459 460 (0.08μ) innodb/lock_mutex 458->460 461 (0.58μ) innodb/trx_sys_lock - read_lock 458->461 463 (0.08μ) innodb/rw_lock_mutex 458->463 464 (0.08μ) innodb/lock_mutex 458->464 465 (0.09μ) innodb/trx_mutex 458->465 466 (0.10μ) innodb/rw_lock_mutex 458->466 462 (0.09μ) innodb/rw_lock_mutex 461->462 468 (0.08μ) innodb/rw_lock_mutex 467->468 469 (0.08μ) innodb/lock_mutex 467->469 470 (0.08μ) innodb/trx_mutex 467->470 471 (0.08μ) innodb/rw_lock_mutex 467->471 473 (0.14μ) sql/Query_cache::structure_guard_mutex 472->473 474 (0.09μ) sql/Query_cache::structure_guard_mutex 472->474 476 (0.20μ) sql/MDL_lock::rwlock - write_lock 475->476 477 (0.24μ) innodb/rseg_mutex 475->477 478 (1.25μ) innodb/trx_sys_lock - write_lock 475->478 481 (0.23μ) innodb/purge_sys_bh_mutex 475->481 482 (0.12μ) innodb/rw_lock_mutex 475->482 483 (0.10μ) innodb/rw_lock_mutex 475->483 484 (0.09μ) innodb/rw_lock_mutex 475->484 485 (0.10μ) innodb/rw_lock_mutex 475->485 486 (0.09μ) innodb/rw_lock_mutex 475->486 487 (0.09μ) innodb/rw_lock_mutex 475->487 488 (0.08μ) innodb/rw_lock_mutex 475->488 489 (0.09μ) innodb/rw_lock_mutex 475->489 490 (0.08μ) innodb/rw_lock_mutex 475->490 491 (1.06μ) innodb/trx_sys_lock - write_lock 475->491 494 (0.12μ) innodb/rw_lock_mutex 475->494 495 (0.11μ) innodb/log_sys_mutex 475->495 496 (0.09μ) innodb/log_flush_order_mutex 475->496 497 (0.08μ) innodb/rw_lock_mutex 475->497 498 (0.08μ) innodb/rw_lock_mutex 475->498 499 (0.16μ) innodb/lock_mutex 475->499 500 (0.08μ) innodb/trx_mutex 475->500 501 (0.80μ) innodb/trx_sys_lock - read_lock 475->501 503 (0.08μ) innodb/rw_lock_mutex 475->503 504 (0.98μ) innodb/trx_sys_lock - write_lock 475->504 507 (0.11μ) innodb/rw_lock_mutex 475->507 508 (0.22μ) innodb/log_sys_mutex 475->508 509 (0.23μ) innodb/fil_system_mutex 475->509 510 (19.05μ) wait/io/file/innodb/innodb_log_file - write 1536 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 475->510 514 (0.18μ) innodb/fil_system_mutex 475->514 515 (0.22μ) innodb/fil_system_mutex 475->515 516 (722.54μ) wait/io/file/innodb/innodb_log_file - sync /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 475->516 517 (0.39μ) innodb/fil_system_mutex 475->517 518 (0.13μ) innodb/log_sys_mutex 475->518 519 (0.18μ) sql/MDL_lock::rwlock - write_lock 475->519 479 (0.09μ) innodb/rw_lock_mutex 478->479 480 (0.08μ) innodb/rw_lock_mutex 478->480 492 (0.09μ) innodb/rw_lock_mutex 491->492 493 (0.09μ) innodb/rw_lock_mutex 491->493 502 (0.08μ) innodb/rw_lock_mutex 501->502 505 (0.09μ) innodb/rw_lock_mutex 504->505 506 (0.08μ) innodb/rw_lock_mutex 504->506 511 (18.16μ) wait/io/file/innodb/innodb_log_file - write 1536 bytes /Users/mark/mysql/lp-mysql-trunk/mysql-test/var/mysqld.1/data/ib_logfile0 510->511 512 (0.09μ) innodb/os_mutex 511->512 513 (0.34μ) innodb/os_mutex 511->513 521 (0.11μ) mysys/THR_LOCK::mutex 520->521 522 (0.11μ) sql/THD::LOCK_thd_data 520->522 523 (0.09μ) sql/LOCK_open 520->523 524 (0.09μ) sql/MDL_lock::rwlock - write_lock 520->524 525 (0.09μ) sql/MDL_lock::rwlock - write_lock 520->525 526 (0.10μ) sql/MDL_map::mutex 520->526 529 (0.25μ) sql/THD::LOCK_thd_data 528->529