annotate tests/gtk/event-stream-tests.el @ 1292:f3437b56874d

[xemacs-hg @ 2003-02-13 09:57:04 by ben] profile updates profile.c: Major reworking. Keep track of new information -- total function timing (includes descendants), GC usage, total GC usage (includes descendants). New functions to be called appropriately from eval.c, alloc.c to keep track of this information. Keep track of when we're actually in a function vs. in its profile, for more accurate timing counts. Track profile overhead separately. Create new mechanism for specifying "internal sections" that are tracked just like regular Lisp functions and even appear in the backtrace if `backtrace-with-internal-sections' is non-nil (t by default for error-checking builds). Add some KKCC information for the straight (non-Elisp) hash table used by profile, which contains Lisp objects in its keys -- but not used yet. Remove old ad-hoc methods for tracking garbage collection, redisplay (which was incorrect anyway when Lisp was called within these sections). Don't record any tick info when blocking under MS Windows, since the timer there is in real time rather than in process time. Make `start-profiling', `stop-profiling' interactive. Be consistent wrt. recursive functions and functions currently on the stack when starting or stopping -- together these make implementing the `total' values extremely difficult. When we start profiling, we act as if we just entered all the functions currently on the stack. Likewise when exiting. Create vars in_profile for tracking time spent inside of profiling, and profiling_lock for setting exclusive access to the main hash table when reading from it or modifying it. (protects against getting screwed up by the signal handle going off at the same time. profile.h: New file. Create macros for declaring internal profiling sections. lisp.h: Move profile-related stuff to profile.h. alloc.c: Keep track of total consing, for profile. Tell profile when we are consing. Use new profile-section method for noting garbage-collection. alloc.c: Abort if we attempt to call the allocator reentrantly. backtrace.h, eval.c: Add info for use by profile in the backtrace frame and transfer PUSH_BACKTRACE/POP_BACKTRACE from eval.c, for use with profile. elhash.c: Author comment. eval.c, lisp.h: New Lisp var `backtrace-with-internal-sections'. Set to t when error-checking is on. eval.c: When unwinding, eval.c: Report to profile when we are about-to-call and just-called wrt. a function. alloc.c, eval.c: Allow for "fake" backtrace frames, for internal sections (used by profile and `backtrace-with-internal-sections'. event-Xt.c, event-gtk.c, event-msw.c, event-tty.c: Record when we are actually blocking on an event, for profile's sake. event-stream.c: Record internal profiling sections for getting, dispatching events. extents.c: Record internal profiling sections for map_extents. hash.c, hash.h: Add pregrow_hash_table_if_necessary(). (Used in profile code since the signal handler is the main grower but can't allow a realloc(). We make sure, at critical points, that the table is large enough.) lread.c: Create internal profiling sections for `load' (which may be triggered internally by autoload, etc.). redisplay.c: Remove old profile_redisplay_flag. Use new macros to declare internal profiling section for redisplay. text.c: Use new macros to declare internal profiling sections for char-byte conversion and internal-external conversion. SEMI-UNRELATED CHANGES: ----------------------- text.c: Update the long comments.
author ben
date Thu, 13 Feb 2003 09:57:08 +0000
parents 0784d089fdc9
children cef5f57bb9e2
Ignore whitespace changes - Everywhere: Within whitespace: At end of lines:
rev   line source
462
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
1 ;also do this: make two frames, one viewing "*scratch*", the other "foo".
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
2 ;in *scratch*, type (sit-for 20)^J
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
3 ;wait a couple of seconds, move cursor to foo, type "a"
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
4 ;a should be inserted in foo. Cursor highlighting should not change in
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
5 ;the meantime.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
6
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
7 ;do it with sleep-for. move cursor into foo, then back into *scratch*
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
8 ;before typing.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
9 ;repeat also with (accept-process-output nil 20)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
10
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
11 ;make sure ^G aborts sit-for, sleep-for and accept-process-output:
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
12
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
13 (defun tst ()
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
14 (list (condition-case c
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
15 (sleep-for 20)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
16 (quit c))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
17 (read-char)))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
18
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
19 (tst)^Ja^G ==> ((quit) 97) with no signal
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
20 (tst)^J^Ga ==> ((quit) 97) with no signal
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
21 (tst)^Jabc^G ==> ((quit) 97) with no signal, and "bc" inserted in buffer
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
22
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
23 ; with sit-for only do the 2nd test.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
24 ; Do all 3 tests with (accept-proccess-output nil 20)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
25
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
26 /*
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
27 Additional test cases for accept-process-output, sleep-for, sit-for.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
28 Be sure you do all of the above checking for C-g and focus, too!
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
29
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
30 ; Make sure that timer handlers are run during, not after sit-for:
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
31 (defun timer-check ()
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
32 (add-timeout 2 '(lambda (ignore) (message "timer ran")) nil)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
33 (sit-for 5)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
34 (message "after sit-for"))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
35
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
36 ; The first message should appear after 2 seconds, and the final message
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
37 ; 3 seconds after that.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
38 ; repeat above test with (sleep-for 5) and (accept-process-output nil 5)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
39
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
40 ; Make sure that process filters are run during, not after sit-for.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
41 (defun fubar ()
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
42 (message "sit-for = %s" (sit-for 30)))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
43 (add-hook 'post-command-hook 'fubar)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
44
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
45 ; Now type M-x shell RET
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
46 ; wait for the shell prompt then send: ls RET
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
47 ; the output of ls should fill immediately, and not wait 30 seconds.
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
48
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
49 ; repeat above test with (sleep-for 30) and (accept-process-output nil 30)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
50
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
51
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
52
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
53 ; Make sure that recursive invocations return immediately:
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
54 (defmacro test-diff-time (start end)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
55 `(+ (* (- (car ,end) (car ,start)) 65536.0)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
56 (- (cadr ,end) (cadr ,start))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
57 (/ (- (caddr ,end) (caddr ,start)) 1000000.0)))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
58
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
59 (defun testee (ignore)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
60 (sit-for 10))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
61
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
62 (defun test-them ()
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
63 (let ((start (current-time))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
64 end)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
65 (add-timeout 2 'testee nil)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
66 (sit-for 5)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
67 (add-timeout 2 'testee nil)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
68 (sleep-for 5)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
69 (add-timeout 2 'testee nil)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
70 (accept-process-output nil 5)
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
71 (setq end (current-time))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
72 (test-diff-time start end)))
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
73
0784d089fdc9 Import from CVS: tag r21-2-46
cvs
parents:
diff changeset
74 (test-them) should sit for 15 seconds.