Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Replay diverge on modified log: bug make-abr2gbr #7

Open
chiache opened this issue Jul 23, 2011 · 9 comments
Open

Replay diverge on modified log: bug make-abr2gbr #7

chiache opened this issue Jul 23, 2011 · 9 comments

Comments

@chiache
Copy link

chiache commented Jul 23, 2011

Detail for the bug:

all: .obj .obj/abr2gbr

.obj:
if [ ! -d $@ ]; then mkdir $@; fi

.obj/%.o: %.c
$(CC) -o $@ $(CFLAGS) -c $<

.obj/abr2gbr: .obj/abr2gbr.o
$(CC) -o $@ $(CFLAGS) $(LIBS) .obj/abr2gbr.o

So, mkdir() will race with open() system call made by gcc.

INFO:root: running post-replay callback...
INFO:root: time: 0.61
INFO:root: running pre-replay callback...
INFO:root: replaying ...
if [ ! -d .obj ]; then mkdir .obj; fi
INFO:root:
Backtrace:
[08] mkdir() = 0
[08] regs: eip: 0073:4001e424, eflags: 00000246, eax: 00000027, ebx: bf883daa, ecx: 000001ff, edx: bf883daa esi: bf881bb8 , edi: 00000001, ebp: bf881b48, esp: bf881a6c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[08] data: input string, ptr = 0xbf883daa, size = 4, ".obj"
[08] resource lock, type = inode, access = write, id = 71, serial = 17, desc = none
[08] resource unlock, id = 71
Replay Diverged:
[05] diverged on event type = scribe_event_resource_lock_extra
RACE 132: replay diverge (200)

@chiache
Copy link
Author

chiache commented Jul 23, 2011

Log file: hp07:/persist/need-diagnose/make-abr2gbr/out.132.log

@orenl
Copy link

orenl commented Jul 24, 2011

thanks.

can you also say where we can look at the original and modified
scribe logs (used to replay) for this case ?

On 07/23/2011 06:06 PM, chiache wrote:

Detail for the bug:

all: .obj .obj/abr2gbr

.obj:
if [ ! -d $@ ]; then mkdir $@; fi

.obj/%.o: %.c
$(CC) -o $@ $(CFLAGS) -c $<

.obj/abr2gbr: .obj/abr2gbr.o
$(CC) -o $@ $(CFLAGS) $(LIBS) .obj/abr2gbr.o

So, mkdir() will race with open() system call made by gcc.

INFO:root: running post-replay callback...
INFO:root: time: 0.61
INFO:root: running pre-replay callback...
INFO:root: replaying ...
if [ ! -d .obj ]; then mkdir .obj; fi
INFO:root:
Backtrace:
[08] mkdir() = 0
[08] regs: eip: 0073:4001e424, eflags: 00000246, eax: 00000027, ebx: bf883daa, ecx: 000001ff, edx: bf883daa esi: bf881bb8 , edi: 00000001, ebp: bf881b48, esp: bf881a6c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[08] data: input string, ptr = 0xbf883daa, size = 4, ".obj"
[08] resource lock, type = inode, access = write, id = 71, serial = 17, desc = none
[08] resource unlock, id = 71
Replay Diverged:
[05] diverged on event type = scribe_event_resource_lock_extra
RACE 132: replay diverge (200)

@chiache
Copy link
Author

chiache commented Jul 24, 2011

original log: hp07:/persist/need-diagnose/make-abr2gbr/out.log

other logs: Log file: hp07:/persist/need-diagnose/make-abr2gbr/out.*.log

@chiache
Copy link
Author

chiache commented Jul 26, 2011

Output: hp07:/persist/need-diagnose/make-abr2gbr/result

@orenl
Copy link

orenl commented Jul 28, 2011

please provide the following (and only this) infromation:

  1. the original execution log (eg. out.log)
  2. the (one) modified execution log that failed (eg. out.NUM.log)
  3. the output of 'racetest -vd ...' when it created that modified log
  4. the divergence trace from racepro (that matches the failure)

pleaes use the latest version of the code to generate these.

thanks !

On 07/26/2011 10:50 AM, chiache wrote:

Output: hp07:/persist/need-diagnose/make-abr2gbr/result

@chiache
Copy link
Author

chiache commented Jul 29, 2011

Update:

original log: hp05:/persist/make-abr2gbr/out.log
modified log: hp05:/persist/make-abr2gbr/out.5.log
output: hp05:/persist/make-abr2gbr/output

backtrace:

Backtrace (100 events):
[06] resource unlock, id = 117
[06] syscall ended
Last events of each known process:
[06] resource unlock, id = 117
[06] syscall ended
[09] resource unlock, id = 31
[09] resource lock, type = inode, access = read, id = 37, serial = 0, desc = none
[09] resource unlock, id = 37
[09] resource lock, type = files_struct, access = write, id = 190, serial = 104, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] fstat64() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000212, eax: 000000c5, ebx: 00000003, ecx: bf989b00, edx: 40197ff4 esi: 0887a5b8, edi: 00000001, ebp: bf989ac4, esp: bf989ab0 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = read, id = 190, serial = 105, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = file, access = write, id = 230, serial = 0, desc = /usr/lib/locale/en_US.utf8/LC_NUMERIC
[09] resource lock, type = inode, access = read, id = 64, serial = 0, desc = none
[09] resource unlock, id = 64
[09] resource unlock, id = 230
[09] data: non-det output, ptr = 0xbf989b00, size = 96, 00000015 00000000 00000000 000c0bc0 000081a4 0000000b 00000000 00000000 00000000 00000000 000000...
[09] syscall ended
[09] mmap_pgoff() = 0x402c9000
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000c0, ebx: 00000000, ecx: 00000036, edx: 00000001 esi: 00000002, edi: 00000003, ebp: 00000000, esp: bf989aa8 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = mmap, access = write, id = 188, serial = 36, desc = none
[09] resource unlock, id = 188
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000213, eax: 00000006, ebx: 00000003, ecx: 40197ff4, edx: 00000003 esi: 0887a5b8, edi: 402c9000, ebp: bf989b6c, esp: bf989abc ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 106, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] open() = -2 ENOENT (No such file or directory)
[09] regs: eip: 0073:4001d424, eflags: 00000296, eax: 00000005, ebx: 0887a960, ecx: 00000000, edx: 00000000 esi: 0887a7e8, edi: 00000000, ebp: bf989b6c, esp: bf989ab4 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0x887a960, size = 36, "/usr/lib/locale/en_US.UTF-8/LC_CTYPE"
[09] resource lock, type = files_struct, access = write, id = 190, serial = 107, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = inode, access = read, id = 1, serial = 0, desc = none
[09] resource unlock, id = 1
[09] resource lock, type = inode, access = read, id = 29, serial = 0, desc = none
[09] resource unlock, id = 29
[09] resource lock, type = inode, access = read, id = 30, serial = 0, desc = none
[09] resource unlock, id = 30
[09] resource lock, type = inode, access = read, id = 31, serial = 0, desc = none
[09] resource unlock, id = 31
[09] resource lock, type = files_struct, access = write, id = 190, serial = 108, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] open() = 3
[09] regs: eip: 0073:4001d424, eflags: 00000296, eax: 00000005, ebx: 0887ac48, ecx: 00000000, edx: 00000000 esi: 0887ac10, edi: 00000001, ebp: bf989b6c, esp: bf989ab4 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0x887ac48, size = 35, "/usr/lib/locale/en_US.utf8/LC_CTYPE"
[09] resource lock, type = files_struct, access = write, id = 190, serial = 109, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = inode, access = read, id = 1, serial = 0, desc = none
[09] resource unlock, id = 1
[09] resource lock, type = inode, access = read, id = 29, serial = 0, desc = none
[09] resource unlock, id = 29
[09] resource lock, type = inode, access = read, id = 30, serial = 0, desc = none
[09] resource unlock, id = 30
[09] resource lock, type = inode, access = read, id = 31, serial = 0, desc = none
[09] resource unlock, id = 31
[09] resource lock, type = inode, access = read, id = 37, serial = 0, desc = none
[09] resource unlock, id = 37
[09] resource lock, type = files_struct, access = write, id = 190, serial = 110, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] fstat64() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000212, eax: 000000c5, ebx: 00000003, ecx: bf989b00, edx: 40197ff4 esi: 0887ac10, edi: 00000001, ebp: bf989ac4, esp: bf989ab0 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = read, id = 190, serial = 111, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = file, access = write, id = 232, serial = 0, desc = /usr/lib/locale/en_US.utf8/LC_CTYPE
[09] resource lock, type = inode, access = read, id = 66, serial = 0, desc = none
[09] resource unlock, id = 66
[09] resource unlock, id = 232
[09] data: non-det output, ptr = 0xbf989b00, size = 96, 00000015 00000000 00000000 000c0bbf 000081a4 00000010 00000000 00000000 00000000 00000000 000000...
[09] syscall ended
[09] mmap_pgoff() = 0x402ca000
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000c0, ebx: 00000000, ecx: 0003e944, edx: 00000001 esi: 00000002, edi: 00000003, ebp: 00000000, esp: bf989aa8 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = mmap, access = write, id = 188, serial = 37, desc = none
[09] resource unlock, id = 188
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000213, eax: 00000006, ebx: 00000003, ecx: 40197ff4, edx: 00000003 esi: 0887ac10, edi: 402ca000, ebp: bf989b6c, esp: bf989abc ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 112, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] mkdir() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 00000027, ebx: bf98adbb, ecx: 000001ff, edx: bf98adbb esi: bf989c88, edi: 00000001, ebp: bf989c18, esp: bf989b3c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0xbf98adbb, size = 4, ".obj"
[09] resource lock, type = inode, access = write, id = 117, serial = 17, desc = none
[09] resource unlock, id = 117
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000286, eax: 00000006, ebx: 00000001, ecx: 00000000, edx: 40197ff4 esi: 401984e0, edi: 00000000, ebp: bf989bc8, esp: bf989b94 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 113, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000286, eax: 00000006, ebx: 00000002, ecx: 00000000, edx: 40197ff4 esi: 40198580, edi: 00000000, ebp: bf989bc8, esp: bf989b94 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 114, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] exit_group() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000fc, ebx: 00000000, ecx: 40198cd8, edx: 00000000 esi: 40196264, edi: 00000000, ebp: bf989c88, esp: bf989c3c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = pid, access = write, id = 177, serial = 2, desc = none
[09] resource unlock, id = 177
Replay Diverged:
[06] diverged on event type = scribe_event_resource_lock_extra
RACE 5: replay diverge (200)

@orenl
Copy link

orenl commented Aug 2, 2011

thanks for the additional info.

unfortunately, there is not enough info in the log to figure out
what process 6 was doing before this diverge.

can you please generate a longer log ?

On 07/29/2011 12:28 PM, chiache wrote:

Update:

original log: hp05:/persist/make-abr2gbr/out.log
modified log: hp05:/persist/make-abr2gbr/out.5.log
output: hp05:/persist/make-abr2gbr/output

backtrace:

Backtrace (100 events):
[06] resource unlock, id = 117
[06] syscall ended
Last events of each known process:
[06] resource unlock, id = 117
[06] syscall ended
[09] resource unlock, id = 31
[09] resource lock, type = inode, access = read, id = 37, serial = 0, desc = none
[09] resource unlock, id = 37
[09] resource lock, type = files_struct, access = write, id = 190, serial = 104, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] fstat64() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000212, eax: 000000c5, ebx: 00000003, ecx: bf989b00, edx: 40197ff4 esi: 0887a5b8, edi: 00000001, ebp: bf989ac4, esp: bf989ab0 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = read, id = 190, serial = 105, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = file, access = write, id = 230, serial = 0, desc = /usr/lib/locale/en_US.utf8/LC_NUMERIC
[09] resource lock, type = inode, access = read, id = 64, serial = 0, desc = none
[09] resource unlock, id = 64
[09] resource unlock, id = 230
[09] data: non-det output, ptr = 0xbf989b00, size = 96, 00000015 00000000 00000000 000c0bc0 000081a4 0000000b 00000000 00000000 00000000 00000000 000000...
[09] syscall ended
[09] mmap_pgoff() = 0x402c9000
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000c0, ebx: 00000000, ecx: 00000036, edx: 00000001 esi: 00000002, edi: 00000003, ebp: 00000000, esp: bf989aa8 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = mmap, access = write, id = 188, serial = 36, desc = none
[09] resource unlock, id = 188
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000213, eax: 00000006, ebx: 00000003, ecx: 40197ff4, edx: 00000003 esi: 0887a5b8, edi: 402c9000, ebp: bf989b6c, esp: bf989abc ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 106, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] open() = -2 ENOENT (No such file or directory)
[09] regs: eip: 0073:4001d424, eflags: 00000296, eax: 00000005, ebx: 0887a960, ecx: 00000000, edx: 00000000 esi: 0887a7e8, edi: 00000000, ebp: bf989b6c, esp: bf989ab4 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0x887a960, size = 36, "/usr/lib/locale/en_US.UTF-8/LC_CTYPE"
[09] resource lock, type = files_struct, access = write, id = 190, serial = 107, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = inode, access = read, id = 1, serial = 0, desc = none
[09] resource unlock, id = 1
[09] resource lock, type = inode, access = read, id = 29, serial = 0, desc = none
[09] resource unlock, id = 29
[09] resource lock, type = inode, access = read, id = 30, serial = 0, desc = none
[09] resource unlock, id = 30
[09] resource lock, type = inode, access = read, id = 31, serial = 0, desc = none
[09] resource unlock, id = 31
[09] resource lock, type = files_struct, access = write, id = 190, serial = 108, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] open() = 3
[09] regs: eip: 0073:4001d424, eflags: 00000296, eax: 00000005, ebx: 0887ac48, ecx: 00000000, edx: 00000000 esi: 0887ac10, edi: 00000001, ebp: bf989b6c, esp: bf989ab4 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0x887ac48, size = 35, "/usr/lib/locale/en_US.utf8/LC_CTYPE"
[09] resource lock, type = files_struct, access = write, id = 190, serial = 109, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = inode, access = read, id = 1, serial = 0, desc = none
[09] resource unlock, id = 1
[09] resource lock, type = inode, access = read, id = 29, serial = 0, desc = none
[09] resource unlock, id = 29
[09] resource lock, type = inode, access = read, id = 30, serial = 0, desc = none
[09] resource unlock, id = 30
[09] resource lock, type = inode, access = read, id = 31, serial = 0, desc = none
[09] resource unlock, id = 31
[09] resource lock, type = inode, access = read, id = 37, serial = 0, desc = none
[09] resource unlock, id = 37
[09] resource lock, type = files_struct, access = write, id = 190, serial = 110, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] fstat64() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000212, eax: 000000c5, ebx: 00000003, ecx: bf989b00, edx: 40197ff4 esi: 0887ac10, edi: 00000001, ebp: bf989ac4, esp: bf989ab0 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = read, id = 190, serial = 111, desc = none
[09] resource unlock, id = 190
[09] resource lock, type = file, access = write, id = 232, serial = 0, desc = /usr/lib/locale/en_US.utf8/LC_CTYPE
[09] resource lock, type = inode, access = read, id = 66, serial = 0, desc = none
[09] resource unlock, id = 66
[09] resource unlock, id = 232
[09] data: non-det output, ptr = 0xbf989b00, size = 96, 00000015 00000000 00000000 000c0bbf 000081a4 00000010 00000000 00000000 00000000 00000000 000000...
[09] syscall ended
[09] mmap_pgoff() = 0x402ca000
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000c0, ebx: 00000000, ecx: 0003e944, edx: 00000001 esi: 00000002, edi: 00000003, ebp: 00000000, esp: bf989aa8 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = mmap, access = write, id = 188, serial = 37, desc = none
[09] resource unlock, id = 188
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000213, eax: 00000006, ebx: 00000003, ecx: 40197ff4, edx: 00000003 esi: 0887ac10, edi: 402ca000, ebp: bf989b6c, esp: bf989abc ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 112, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] mkdir() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 00000027, ebx: bf98adbb, ecx: 000001ff, edx: bf98adbb esi: bf989c88, edi: 00000001, ebp: bf989c18, esp: bf989b3c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] data: input string, ptr = 0xbf98adbb, size = 4, ".obj"
[09] resource lock, type = inode, access = write, id = 117, serial = 17, desc = none
[09] resource unlock, id = 117
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000286, eax: 00000006, ebx: 00000001, ecx: 00000000, edx: 40197ff4 esi: 401984e0, edi: 00000000, ebp: bf989bc8, esp: bf989b94 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 113, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] close() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000286, eax: 00000006, ebx: 00000002, ecx: 00000000, edx: 40197ff4 esi: 40198580, edi: 00000000, ebp: bf989bc8, esp: bf989b94 ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = files_struct, access = write, id = 190, serial = 114, desc = none
[09] resource unlock, id = 190
[09] syscall ended
[09] exit_group() = 0
[09] regs: eip: 0073:4001d424, eflags: 00000246, eax: 000000fc, ebx: 00000000, ecx: 40198cd8, edx: 00000000 esi: 40196264, edi: 00000000, ebp: bf989c88, esp: bf989c3c ds: 007b, es: 007b, fs: 0000, gs: 0033, ss: 007b
[09] resource lock, type = pid, access = write, id = 177, serial = 2, desc = none
[09] resource unlock, id = 177
Replay Diverged:
[06] diverged on event type = scribe_event_resource_lock_extra
RACE 5: replay diverge (200)

@orenl
Copy link

orenl commented Aug 4, 2011

chia-che,

nico and I investigated the makefile divergence problem.

we reached the conclusion that the divergence for RACE 5 is entirely
legitimate - because it's a false-positive.

in other words, we were chasing the wrong target !

we identified the pair of system calls in the log which are the root
cause of the bug - PID 12 -> open(), PID 9 -> mkdir().

we then ran 'racepro show-races -C 200 ..." and it generated a total of
127 races (note the '-C 200' because the resource in question, which is
the "current directory", had more than the default 100 cutoff races).

in particular, RACE 98 is the one that should trigger the problem.

(see the entire output below).

everything is in /tmp/orenl on hp05, and the generated logs and the
output of racepro is in /tmp/orenl/blah.

we didn't try to replay them -> that's for you.

please see if the bug is produced by that race.

thanks !

On 07/29/2011 12:28 PM, chiache wrote:

Update:

original log: hp05:/persist/make-abr2gbr/out.log
modified log: hp05:/persist/make-abr2gbr/out.5.log
output: hp05:/persist/make-abr2gbr/output

[...]

---- output file ----

root@hp05:/tmp/orenl# racepro -v show-races -c 200 -o blah/blah out.log
INFO:root:resource 1 has too many events (1425); skip
INFO:root:resource 29 has too many events (1204); skip
INFO:root:resource 30 has too many events (675); skip
INFO:root:resource 148 has too many events (261); skip
INFO:root:resource 233 has too many events (329); skip
INFO:root:resource 234 has too many events (630); skip
INFO:root:resource 235 has too many events (294); skip
INFO:root:resource 236 has too many events (231); skip
INFO:root:resource 242 has too many events (1810); skip
INFO:root:resource 663 has too many events (1290); skip

INFO:root:resource 757 has too many events (217); skip

RESOURCE

found 125 potential races

RACE 1: pid 11 #179 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 2: pid 11 #1080 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 3: pid 11 #401 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 4: pid 11 #796 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 5: pid 11 #561 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 6: pid 11 #1311 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 7: pid 11 #363 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 8: pid 11 #695 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 9: pid 11 #987 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 10: pid 11 #825 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 11: pid 11 #329 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 12: pid 11 #507 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 13: pid 11 #551 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 14: pid 11 #251 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 15: pid 11 #642 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 16: pid 11 #517 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 17: pid 11 #1302 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 18: pid 11 #1185 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 19: pid 11 #315 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 20: pid 11 #1229 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 21: pid 11 #422 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 22: pid 11 #1337 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 23: pid 11 #893 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 24: pid 11 #566 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 25: pid 11 #1255 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 26: pid 11 #305 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 27: pid 11 #1194 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 28: pid 11 #717 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 29: pid 11 #668 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 30: pid 11 #572 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 31: pid 11 #1132 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 32: pid 11 #1320 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 33: pid 11 #1176 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 34: pid 11 #1110 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 35: pid 11 #143 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 36: pid 11 #131 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 37: pid 11 #1097 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 38: pid 11 #464 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 39: pid 11 #902 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 40: pid 11 #527 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 41: pid 11 #1220 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 42: pid 11 #1350 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 43: pid 11 #622 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 44: pid 12 #69 [open()=3] -> pid 6 #216 [stat64()=0]
RACE 45: pid 11 #474 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 46: pid 9 #126 [mkdir()=0] -> pid 6 #189 [stat64()=0]
RACE 47: pid 11 #654 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 48: pid 11 #268 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 49: pid 11 #1273 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 50: pid 11 #612 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 51: pid 11 #1119 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 52: pid 11 #1207 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 53: pid 11 #911 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 54: pid 11 #704 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 55: pid 11 #556 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 56: pid 11 #231 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 57: pid 11 #214 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 58: pid 11 #816 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 59: pid 11 #339 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 60: pid 11 #281 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 61: pid 11 #373 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 62: pid 11 #969 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 63: pid 11 #978 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 64: pid 11 #450 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 65: pid 11 #1154 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 66: pid 11 #602 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 67: pid 11 #1363 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 68: pid 11 #947 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 69: pid 11 #865 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 70: pid 11 #128 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 71: pid 11 #1246 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 72: pid 11 #1033 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 73: pid 11 #663 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 74: pid 10 #101 [access()=0] -> pid 9 #126 [mkdir()=0]
RACE 75: pid 11 #252 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 76: pid 11 #162 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 77: pid 9 #126 [mkdir()=0] -> pid 6 #188 [stat64()=-2]
RACE 78: pid 11 #1145 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 79: pid 11 #197 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 80: pid 11 #1167 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 81: pid 11 #1011 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 82: pid 11 #291 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 83: pid 11 #349 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 84: pid 11 #933 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 85: pid 11 #1050 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 86: pid 11 #778 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 87: pid 11 #920 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 88: pid 11 #387 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 89: pid 11 #855 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 90: pid 11 #498 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 91: pid 11 #956 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 92: pid 11 #860 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 93: pid 11 #142 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 94: pid 11 #768 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 95: pid 11 #196 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 96: pid 11 #754 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 97: pid 11 #1071 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 98: pid 12 #69 [open()=3] -> pid 9 #126 [mkdir()=0]
RACE 99: pid 11 #144 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 100: pid 11 #997 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 101: pid 9 #126 [mkdir()=0] -> pid 6 #187 [stat64()=-2]
RACE 102: pid 11 #180 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 103: pid 11 #541 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 104: pid 11 #581 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 105: pid 11 #145 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 106: pid 11 #436 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 107: pid 11 #132 [open()=3] -> pid 9 #126 [mkdir()=0]
RACE 108: pid 11 #726 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 109: pid 11 #884 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 110: pid 12 #68 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 111: pid 11 #740 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 112: pid 11 #1024 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 113: pid 11 #632 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 114: pid 11 #488 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 115: pid 11 #806 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 116: pid 11 #673 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 117: pid 11 #269 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 118: pid 11 #1002 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 119: pid 11 #161 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 120: pid 11 #834 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 121: pid 11 #412 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 122: pid 11 #870 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 123: pid 11 #230 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 124: pid 11 #682 [open()=-2] -> pid 9 #126 [mkdir()=0]

RACE 125: pid 11 #213 [stat64()=-2] -> pid 9 #126 [mkdir()=0]

EXIT-WAIT

found 2 potential races

RACE 126: pid 7 #51 [exit_group()=0] -> pid 6 #197 [wait4()=8] -> pid 8 #75 [exit_group()=0]

RACE 127: pid 10 #162 [exit_group()=0] -> pid 6 #209 [wait4()=7] -> pid 7 #51 [exit_group()=0]

SIGNAL

found 0 potential races

Generated 127 logs for races out of 127 candidates

@orenl
Copy link

orenl commented Aug 4, 2011

oops.. the command was supposed to be "-c 200" no "-C 200".

and: we used the latest verison of racepro as installed in hp05,
which is the latest in 'master' branch on github.

(unclear how you got your results before...)

On 08/04/2011 01:58 PM, Oren Laadan wrote:

chia-che,

nico and I investigated the makefile divergence problem.

we reached the conclusion that the divergence for RACE 5 is entirely
legitimate - because it's a false-positive.

in other words, we were chasing the wrong target !

we identified the pair of system calls in the log which are the root
cause of the bug - PID 12 -> open(), PID 9 -> mkdir().

we then ran 'racepro show-races -C 200 ..." and it generated a total of
127 races (note the '-C 200' because the resource in question, which is
the "current directory", had more than the default 100 cutoff races).

in particular, RACE 98 is the one that should trigger the problem.

(see the entire output below).

everything is in /tmp/orenl on hp05, and the generated logs and the
output of racepro is in /tmp/orenl/blah.

we didn't try to replay them -> that's for you.

please see if the bug is produced by that race.

thanks !

On 07/29/2011 12:28 PM, chiache wrote:

Update:

original log: hp05:/persist/make-abr2gbr/out.log
modified log: hp05:/persist/make-abr2gbr/out.5.log
output: hp05:/persist/make-abr2gbr/output

[...]

---- output file ----

root@hp05:/tmp/orenl# racepro -v show-races -c 200 -o blah/blah out.log
INFO:root:resource 1 has too many events (1425); skip
INFO:root:resource 29 has too many events (1204); skip
INFO:root:resource 30 has too many events (675); skip
INFO:root:resource 148 has too many events (261); skip
INFO:root:resource 233 has too many events (329); skip
INFO:root:resource 234 has too many events (630); skip
INFO:root:resource 235 has too many events (294); skip
INFO:root:resource 236 has too many events (231); skip
INFO:root:resource 242 has too many events (1810); skip
INFO:root:resource 663 has too many events (1290); skip

INFO:root:resource 757 has too many events (217); skip

RESOURCE

found 125 potential races

RACE 1: pid 11 #179 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 2: pid 11 #1080 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 3: pid 11 #401 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 4: pid 11 #796 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 5: pid 11 #561 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 6: pid 11 #1311 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 7: pid 11 #363 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 8: pid 11 #695 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 9: pid 11 #987 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 10: pid 11 #825 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 11: pid 11 #329 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 12: pid 11 #507 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 13: pid 11 #551 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 14: pid 11 #251 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 15: pid 11 #642 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 16: pid 11 #517 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 17: pid 11 #1302 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 18: pid 11 #1185 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 19: pid 11 #315 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 20: pid 11 #1229 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 21: pid 11 #422 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 22: pid 11 #1337 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 23: pid 11 #893 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 24: pid 11 #566 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 25: pid 11 #1255 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 26: pid 11 #305 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 27: pid 11 #1194 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 28: pid 11 #717 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 29: pid 11 #668 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 30: pid 11 #572 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 31: pid 11 #1132 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 32: pid 11 #1320 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 33: pid 11 #1176 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 34: pid 11 #1110 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 35: pid 11 #143 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 36: pid 11 #131 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 37: pid 11 #1097 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 38: pid 11 #464 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 39: pid 11 #902 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 40: pid 11 #527 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 41: pid 11 #1220 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 42: pid 11 #1350 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 43: pid 11 #622 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 44: pid 12 #69 [open()=3] -> pid 6 #216 [stat64()=0]
RACE 45: pid 11 #474 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 46: pid 9 #126 [mkdir()=0] -> pid 6 #189 [stat64()=0]
RACE 47: pid 11 #654 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 48: pid 11 #268 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 49: pid 11 #1273 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 50: pid 11 #612 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 51: pid 11 #1119 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 52: pid 11 #1207 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 53: pid 11 #911 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 54: pid 11 #704 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 55: pid 11 #556 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 56: pid 11 #231 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 57: pid 11 #214 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 58: pid 11 #816 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 59: pid 11 #339 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 60: pid 11 #281 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 61: pid 11 #373 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 62: pid 11 #969 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 63: pid 11 #978 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 64: pid 11 #450 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 65: pid 11 #1154 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 66: pid 11 #602 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 67: pid 11 #1363 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 68: pid 11 #947 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 69: pid 11 #865 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 70: pid 11 #128 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 71: pid 11 #1246 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 72: pid 11 #1033 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 73: pid 11 #663 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 74: pid 10 #101 [access()=0] -> pid 9 #126 [mkdir()=0]
RACE 75: pid 11 #252 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 76: pid 11 #162 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 77: pid 9 #126 [mkdir()=0] -> pid 6 #188 [stat64()=-2]
RACE 78: pid 11 #1145 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 79: pid 11 #197 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 80: pid 11 #1167 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 81: pid 11 #1011 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 82: pid 11 #291 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 83: pid 11 #349 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 84: pid 11 #933 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 85: pid 11 #1050 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 86: pid 11 #778 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 87: pid 11 #920 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 88: pid 11 #387 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 89: pid 11 #855 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 90: pid 11 #498 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 91: pid 11 #956 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 92: pid 11 #860 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 93: pid 11 #142 [stat64()=0] -> pid 9 #126 [mkdir()=0]
RACE 94: pid 11 #768 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 95: pid 11 #196 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 96: pid 11 #754 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 97: pid 11 #1071 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 98: pid 12 #69 [open()=3] -> pid 9 #126 [mkdir()=0]
RACE 99: pid 11 #144 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 100: pid 11 #997 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 101: pid 9 #126 [mkdir()=0] -> pid 6 #187 [stat64()=-2]
RACE 102: pid 11 #180 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 103: pid 11 #541 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 104: pid 11 #581 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 105: pid 11 #145 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 106: pid 11 #436 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 107: pid 11 #132 [open()=3] -> pid 9 #126 [mkdir()=0]
RACE 108: pid 11 #726 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 109: pid 11 #884 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 110: pid 12 #68 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 111: pid 11 #740 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 112: pid 11 #1024 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 113: pid 11 #632 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 114: pid 11 #488 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 115: pid 11 #806 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 116: pid 11 #673 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 117: pid 11 #269 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 118: pid 11 #1002 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 119: pid 11 #161 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 120: pid 11 #834 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 121: pid 11 #412 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 122: pid 11 #870 [open()=-2] -> pid 9 #126 [mkdir()=0]
RACE 123: pid 11 #230 [stat64()=-2] -> pid 9 #126 [mkdir()=0]
RACE 124: pid 11 #682 [open()=-2] -> pid 9 #126 [mkdir()=0]

RACE 125: pid 11 #213 [stat64()=-2] -> pid 9 #126 [mkdir()=0]

EXIT-WAIT

found 2 potential races

RACE 126: pid 7 #51 [exit_group()=0] -> pid 6 #197 [wait4()=8] -> pid 8 #75 [exit_group()=0]

RACE 127: pid 10 #162 [exit_group()=0] -> pid 6 #209 [wait4()=7] -> pid 7 #51 [exit_group()=0]

SIGNAL

found 0 potential races

Generated 127 logs for races out of 127 candidates


RacePro mailing list
RacePro@lists.cs.columbia.edu
https://lists.cs.columbia.edu/cucslists/listinfo/racepro

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants