119e252baSAlexander Leidinger #!/usr/sbin/dtrace -qs 219e252baSAlexander Leidinger 319e252baSAlexander Leidinger /*- 419e252baSAlexander Leidinger * Copyright (c) 2011-2012 Alexander Leidinger <netchild@FreeBSD.org> 519e252baSAlexander Leidinger * All rights reserved. 619e252baSAlexander Leidinger * 719e252baSAlexander Leidinger * Redistribution and use in source and binary forms, with or without 819e252baSAlexander Leidinger * modification, are permitted provided that the following conditions 919e252baSAlexander Leidinger * are met: 1019e252baSAlexander Leidinger * 1. Redistributions of source code must retain the above copyright 1119e252baSAlexander Leidinger * notice, this list of conditions and the following disclaimer 1219e252baSAlexander Leidinger * in this position and unchanged. 1319e252baSAlexander Leidinger * 2. Redistributions in binary form must reproduce the above copyright 1419e252baSAlexander Leidinger * notice, this list of conditions and the following disclaimer in the 1519e252baSAlexander Leidinger * documentation and/or other materials provided with the distribution. 1619e252baSAlexander Leidinger * 1719e252baSAlexander Leidinger * THIS SOFTWARE IS PROVIDED BY THE AUTHOR ``AS IS'' AND ANY EXPRESS OR 1819e252baSAlexander Leidinger * IMPLIED WARRANTIES, INCLUDING, BUT NOT LIMITED TO, THE IMPLIED WARRANTIES 1919e252baSAlexander Leidinger * OF MERCHANTABILITY AND FITNESS FOR A PARTICULAR PURPOSE ARE DISCLAIMED. 2019e252baSAlexander Leidinger * IN NO EVENT SHALL THE AUTHOR BE LIABLE FOR ANY DIRECT, INDIRECT, 2119e252baSAlexander Leidinger * INCIDENTAL, SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, BUT 2219e252baSAlexander Leidinger * NOT LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS OF USE, 2319e252baSAlexander Leidinger * DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED AND ON ANY 2419e252baSAlexander Leidinger * THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, OR TORT 2519e252baSAlexander Leidinger * (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF THE USE OF 2619e252baSAlexander Leidinger * THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF SUCH DAMAGE. 2719e252baSAlexander Leidinger */ 2819e252baSAlexander Leidinger 2919e252baSAlexander Leidinger /** 3019e252baSAlexander Leidinger * Trace futex operations: 3119e252baSAlexander Leidinger * - internal locks 3219e252baSAlexander Leidinger * - size of the futex list 3319e252baSAlexander Leidinger * - report error conditions (emulation errors, kernel errors, 3419e252baSAlexander Leidinger * programming errors) 3519e252baSAlexander Leidinger * - execution time (wallclock) of futex related functions 3619e252baSAlexander Leidinger */ 3719e252baSAlexander Leidinger 3819e252baSAlexander Leidinger #pragma D option specsize=32m 3919e252baSAlexander Leidinger 4019e252baSAlexander Leidinger /* Error conditions */ 4119e252baSAlexander Leidinger linuxulator*:futex:futex_get:error, 4219e252baSAlexander Leidinger linuxulator*:futex:futex_sleep:requeue_error, 4319e252baSAlexander Leidinger linuxulator*:futex:futex_sleep:sleep_error, 4419e252baSAlexander Leidinger linuxulator*:futex:futex_wait:copyin_error, 4519e252baSAlexander Leidinger linuxulator*:futex:futex_wait:itimerfix_error, 4619e252baSAlexander Leidinger linuxulator*:futex:futex_wait:sleep_error, 4719e252baSAlexander Leidinger linuxulator*:futex:futex_atomic_op:missing_access_check, 4819e252baSAlexander Leidinger linuxulator*:futex:futex_atomic_op:unimplemented_op, 4919e252baSAlexander Leidinger linuxulator*:futex:futex_atomic_op:unimplemented_cmp, 5019e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_clockswitch, 5119e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:copyin_error, 5219e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unhandled_efault, 5319e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_lock_pi, 5419e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_unlock_pi, 5519e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_trylock_pi, 5619e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_wait_requeue_pi, 5719e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unimplemented_cmp_requeue_pi, 5819e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:unknown_operation, 5919e252baSAlexander Leidinger linuxulator*:futex:linux_get_robust_list:copyout_error, 6019e252baSAlexander Leidinger linuxulator*:futex:handle_futex_death:copyin_error, 6119e252baSAlexander Leidinger linuxulator*:futex:fetch_robust_entry:copyin_error, 6219e252baSAlexander Leidinger linuxulator*:futex:release_futexes:copyin_error 6319e252baSAlexander Leidinger { 6419e252baSAlexander Leidinger printf("ERROR: %s in %s:%s:%s\n", probename, probeprov, probemod, 6519e252baSAlexander Leidinger probefunc); 6619e252baSAlexander Leidinger stack(); 6719e252baSAlexander Leidinger ustack(); 6819e252baSAlexander Leidinger } 6919e252baSAlexander Leidinger 7019e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:invalid_cmp_requeue_use, 7119e252baSAlexander Leidinger linuxulator*:futex:linux_sys_futex:deprecated_requeue, 7219e252baSAlexander Leidinger linuxulator*:futex:linux_set_robust_list:size_error 7319e252baSAlexander Leidinger { 7419e252baSAlexander Leidinger printf("WARNING: %s:%s:%s:%s in application %s, maybe an application error?\n", 7519e252baSAlexander Leidinger probename, probeprov, probemod, probefunc, execname); 7619e252baSAlexander Leidinger stack(); 7719e252baSAlexander Leidinger ustack(); 7819e252baSAlexander Leidinger } 7919e252baSAlexander Leidinger 8019e252baSAlexander Leidinger 8119e252baSAlexander Leidinger /* Per futex checks/statistics */ 8219e252baSAlexander Leidinger 8319e252baSAlexander Leidinger linuxulator*:futex:futex:create 8419e252baSAlexander Leidinger { 8519e252baSAlexander Leidinger ++futex_count; 8619e252baSAlexander Leidinger @max_futexes = max(futex_count); 8719e252baSAlexander Leidinger } 8819e252baSAlexander Leidinger 8919e252baSAlexander Leidinger linuxulator*:futex:futex:destroy 9019e252baSAlexander Leidinger /futex_count == 0/ 9119e252baSAlexander Leidinger { 9219e252baSAlexander Leidinger printf("ERROR: Request to destroy a futex which was not created,\n"); 9319e252baSAlexander Leidinger printf(" or this script was started after some futexes where\n"); 9419e252baSAlexander Leidinger printf(" created. Stack trace:\n"); 9519e252baSAlexander Leidinger stack(); 9619e252baSAlexander Leidinger ustack(); 9719e252baSAlexander Leidinger } 9819e252baSAlexander Leidinger 9919e252baSAlexander Leidinger linuxulator*:futex:futex:destroy 10019e252baSAlexander Leidinger { 10119e252baSAlexander Leidinger --futex_count; 10219e252baSAlexander Leidinger } 10319e252baSAlexander Leidinger 10419e252baSAlexander Leidinger 10519e252baSAlexander Leidinger /* Internal locks */ 10619e252baSAlexander Leidinger 10719e252baSAlexander Leidinger linuxulator*:locks:futex_mtx:locked 10819e252baSAlexander Leidinger { 10919e252baSAlexander Leidinger ++check[probefunc, arg0]; 11019e252baSAlexander Leidinger @stats[probefunc] = count(); 11119e252baSAlexander Leidinger 11219e252baSAlexander Leidinger ts[probefunc] = timestamp; 11319e252baSAlexander Leidinger spec[probefunc] = speculation(); 11419e252baSAlexander Leidinger printf("Stacktrace of last lock operation of the %s:\n", probefunc); 11519e252baSAlexander Leidinger stack(); 11619e252baSAlexander Leidinger } 11719e252baSAlexander Leidinger 11819e252baSAlexander Leidinger linuxulator*:locks:futex_mtx:unlock 11919e252baSAlexander Leidinger /check[probefunc, arg0] == 0/ 12019e252baSAlexander Leidinger { 1211ce4275dSPedro F. Giffuni printf("ERROR: unlock attempt of unlocked %s (%p),", probefunc, arg0); 12219e252baSAlexander Leidinger printf(" missing SDT probe in kernel, or dtrace program started"); 12319e252baSAlexander Leidinger printf(" while the %s was already held (race condition).", probefunc); 12419e252baSAlexander Leidinger printf(" Stack trace follows:"); 12519e252baSAlexander Leidinger stack(); 12619e252baSAlexander Leidinger } 12719e252baSAlexander Leidinger 12819e252baSAlexander Leidinger linuxulator*:locks:futex_mtx:unlock 12919e252baSAlexander Leidinger { 13019e252baSAlexander Leidinger discard(spec[probefunc]); 13119e252baSAlexander Leidinger spec[probefunc] = 0; 13219e252baSAlexander Leidinger --check[probefunc, arg0]; 13319e252baSAlexander Leidinger } 13419e252baSAlexander Leidinger 13519e252baSAlexander Leidinger /* Timeout handling for internal locks */ 13619e252baSAlexander Leidinger 13719e252baSAlexander Leidinger tick-10s 13819e252baSAlexander Leidinger /spec["futex_mtx"] != 0 && timestamp - ts["futex_mtx"] >= 9999999000/ 13919e252baSAlexander Leidinger { 14019e252baSAlexander Leidinger commit(spec["futex_mtx"]); 14119e252baSAlexander Leidinger spec["futex_mtx"] = 0; 14219e252baSAlexander Leidinger } 14319e252baSAlexander Leidinger 14419e252baSAlexander Leidinger 14519e252baSAlexander Leidinger /* Timing statistings */ 14619e252baSAlexander Leidinger 14719e252baSAlexander Leidinger linuxulator*:futex::entry 14819e252baSAlexander Leidinger { 14919e252baSAlexander Leidinger self->time[probefunc] = timestamp; 15019e252baSAlexander Leidinger @calls[probeprov, execname, probefunc] = count(); 15119e252baSAlexander Leidinger } 15219e252baSAlexander Leidinger 15319e252baSAlexander Leidinger linuxulator*:futex::return 15419e252baSAlexander Leidinger /self->time[probefunc] != 0/ 15519e252baSAlexander Leidinger { 15619e252baSAlexander Leidinger this->timediff = self->time[probefunc] - timestamp; 15719e252baSAlexander Leidinger 15819e252baSAlexander Leidinger @timestats[probeprov, execname, probefunc] = quantize(this->timediff); 15919e252baSAlexander Leidinger @longest[probeprov, probefunc] = max(this->timediff); 16019e252baSAlexander Leidinger 16119e252baSAlexander Leidinger self->time[probefunc] = 0; 16219e252baSAlexander Leidinger } 16319e252baSAlexander Leidinger 16419e252baSAlexander Leidinger 16519e252baSAlexander Leidinger /* Statistics */ 16619e252baSAlexander Leidinger 16719e252baSAlexander Leidinger END 16819e252baSAlexander Leidinger { 16919e252baSAlexander Leidinger printf("Number of locks per type:"); 17019e252baSAlexander Leidinger printa(@stats); 17119e252baSAlexander Leidinger printf("Number of maximum number of futexes in the futex list:"); 17219e252baSAlexander Leidinger printa(@max_futexes); 17319e252baSAlexander Leidinger printf("Number of futexes still existing: %d", futex_count); 17419e252baSAlexander Leidinger printf("Number of calls per provider/application/kernel function:"); 17519e252baSAlexander Leidinger printa(@calls); 17619e252baSAlexander Leidinger printf("Wallclock-timing statistics per provider/application/kernel function (in ns):"); 17719e252baSAlexander Leidinger printa(@timestats); 17819e252baSAlexander Leidinger printf("Longest running (wallclock!) functions per provider (in ns):"); 17919e252baSAlexander Leidinger printa(@longest); 18019e252baSAlexander Leidinger } 181