/* $1: dev_t $2: RWBS $3: strlen($2) Track request order between block_io_start and block_rq_complete. Sequence starts at 1 so 0 means "never seen". On first valid completion, sync complete_seq to handle probe attachment races. block_rq_complete listed first to reduce missed completion window. */ BEGIN { @start_seq = (uint64)1; @complete_seq = (uint64)0; @out_of_order = (uint64)0; @start_order[0] = (uint64)0; delete(@start_order[0]); printf("BPFTRACE_READY\n"); } tracepoint:block:block_rq_complete /(int64)args.dev == $1 && !strncmp(args.rwbs, str($2), $3)/ { $expected = @start_order[args.sector]; if ($expected > 0) { if (@complete_seq == 0) { @complete_seq = $expected; } if ($expected != @complete_seq) { printf("out_of_order: sector %llu started at seq %llu but completed at seq %llu\n", args.sector, $expected, @complete_seq); @out_of_order = @out_of_order + 1; } delete(@start_order[args.sector]); @complete_seq = @complete_seq + 1; } } tracepoint:block:block_io_start /(int64)args.dev == $1 && !strncmp(args.rwbs, str($2), $3)/ { @start_order[args.sector] = @start_seq; @start_seq = @start_seq + 1; } END { printf("total_start: %llu total_complete: %llu out_of_order: %llu\n", @start_seq - 1, @complete_seq, @out_of_order); clear(@start_order); clear(@start_seq); clear(@complete_seq); clear(@out_of_order); }