Announcement

Announcement Module
Collapse
No announcement yet.

Odd show profile output

Page Title Module
Move Remove Collapse
X
Conversation Detail Module
Collapse
  • Filter
  • Time
  • Show
Clear All
new posts

  • Odd show profile output

    I am seeing a lot of max value for int columns in the show profile, even for queries running 30 seconds it seems Status and duration are accurate but the cpu / context and other variable are not working correctly. Is this something you guys have seen reported , or maybe plan to address as it makes determine why a Status was slow very hard if I cant trust the number. I found no useful bugs in the mysql bug site, since this is a community feature as they put it.

    | Status | Duration | CPU_user | CPU_system | Context_voluntary | Context_involuntary | Block_ops_in | Block_ops_out | Messages_sent | Messages_received | Page_faults_major | Page_faults_minor | Swaps |
    ------------------------------------------------------------ ------------------------------------------------------------ ------------------------------------------------------------ ------------------------------------------------
    | starting | 0.000036 | -999.999999 | -999.999999 | 1224541253 | 942490429 | 2147483647 | 468590881 | 1291310322 | 2147483647 | 2147483647 | 2147483647 | 2147483647 |
    | checking permissions | 0.000003 | 999.999999 | 999.999999 | 2147483647 | 2147483647 | 1612148585 | 2147483647 | 2147483647 | 21632545 | 1449353303 | 1110589408 | 1411125523 |
    | checking permissions | 0.000001 | 0.000000 | 999.999999 | 2147483647 | 992891663 | 2147483647 | 354225676 | 2147483647 | 1427985152 | 246664143 | 2147483647 | 2147483647 |
    | checking permissions | 0.000002 | -999.999999 | -999.999999 | 50656502 | 2147483647 | 803715860 | 2147483647 | 51048001 | 2147483647 | 2147483647 | 2147483647 | 2147483647 |
    | Opening tables | 0.000009 | 320.000320 | 999.999999 | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 2147483647 | 393472 |
    | System lock | 0.000002 | -999.999999 | -999.999999 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 500154580 | 223064627 | 1005204018 | 2830654 |
    | Table lock | 0.000006 | 999.999999 | -999.999999 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 2147483647 |
    | init | 0.000017 | 999.999999 | -999.999999 | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0 |
    | optimizing | 0.000020 | -999.999999 | 877.553344 | 1 | 679168904 | 0 | 0 | 10080144 | 2147483647 | 0 | 0 | 0 |
    | statistics | 0.000102 | 999.999999 | -877.551827 | 10062473 | 2147483647 | 0 | 1068237904 | 1058157760 | 1240036804 | 9701616 | 0 | 679171016 |
    | preparing | 0.000017 | -999.999999 | -999.999999 | 2147483647 | 1068238136 | 0 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 1068144656 | 2147483647 |
    | executing | 0.000003 | 999.999999 | 999.999999 | 679171192 | 2147483647 | 14419648 | 7054400 | 2147483647 | 679171226 | 0 | 2147483647 | 0 |
    | Sending data | 33.202054 | 999.999999 | 0.000000 | 2147483647 | 2147483647 | 2147483647 | 2147483647 | 261439267 | 137708633 | 112 | 112 | 0 |
    | end | 0.000011 | -176.000000 | 0.000000 | 0 | 0 | 0 | 1585576704 | 2147483647 | 584122372 | 0 | 0 | 0 |
    | query end | 0.000004 | 176.000000 | 0.000000 | 0 | 0 | 0 | 16777216 | 787158599 | 2147483647 | 0 | 0 | 0 |
    | freeing items | 0.001657 | -176.000000 | 0.000000 | 0 | 0 | 0 | 0 | 0 | 218103808 | 0 | 0 | 0 |
    | logging slow query | 0.000002 | 176.000000 | 0.000000 | 0 | 2147483647 | 0 | 2147483647 | 719435503 | 1521680517 | 0 | 0 | 0 |
    | logging slow query | 0.000293 | -176.000000 | 0.000000 | 0 | 1 | 0 | 16777216 | 2147483647 | 2147483647 | 0 | 0 | 0 |
    | cleaning up | 0.000005 | 176.000000 | 0.000000 | 1 | 2147483647 | 0 | 2147483647 | 2147483647 | 2147483647 | 0
Working...
X